builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0085 starttime: 1481902336.93 results: success (0) buildid: 20161216062349 builduid: e22b0ae9dc934263bbd4e58670e869d7 revision: ae98ffdc57822f068c011e305ea8a9662dd11e01 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-16 07:32:16.929016) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-16 07:32:16.929555) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-16 07:32:16.929848) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-16 07:32:16.954772) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 07:32:16.955164) ========= 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.R4LlZCmSFP/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.tpsZVJBqOr/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-16 07:32:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 131M=0s 2016-12-16 07:32:17 (131 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.100463 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 07:32:17.079256) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 07:32:17.079575) ========= 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.R4LlZCmSFP/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.tpsZVJBqOr/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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.019572 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 07:32:17.128785) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-16 07:32:17.129137) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ae98ffdc57822f068c011e305ea8a9662dd11e01 --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 ae98ffdc57822f068c011e305ea8a9662dd11e01 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.R4LlZCmSFP/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.tpsZVJBqOr/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-16 07:32:17,205 truncating revision to first 12 chars 2016-12-16 07:32:17,205 Setting DEBUG logging. 2016-12-16 07:32:17,206 attempt 1/10 2016-12-16 07:32:17,206 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ae98ffdc5782?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-16 07:32:18,980 unpacking tar archive at: mozilla-aurora-ae98ffdc5782/testing/mozharness/ program finished with exit code 0 elapsedTime=2.021090 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-16 07:32:19.173678) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-16 07:32:19.174015) ========= script_repo_revision: ae98ffdc57822f068c011e305ea8a9662dd11e01 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-16 07:32:19.174394) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-16 07:32:19.174662) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-16 07:32:19.194521) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-12-16 07:32:19.194912) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.R4LlZCmSFP/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.tpsZVJBqOr/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 07:32:19 INFO - MultiFileLogger online at 20161216 07:32:19 in /builds/slave/test 07:32:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:32:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:32:19 INFO - {'append_to_log': False, 07:32:19 INFO - 'base_work_dir': '/builds/slave/test', 07:32:19 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:32:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:32:19 INFO - 'branch': 'Mozilla-Aurora', 07:32:19 INFO - 'buildbot_json_path': 'buildprops.json', 07:32:19 INFO - 'config_files': ('talos/mac_config.py',), 07:32:19 INFO - 'default_actions': ('clobber', 07:32:19 INFO - 'read-buildbot-config', 07:32:19 INFO - 'download-and-extract', 07:32:19 INFO - 'populate-webroot', 07:32:19 INFO - 'create-virtualenv', 07:32:19 INFO - 'install', 07:32:19 INFO - 'run-tests'), 07:32:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:32:19 INFO - 'download_minidump_stackwalk': True, 07:32:19 INFO - 'download_symbols': 'ondemand', 07:32:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:32:19 INFO - 'tooltool.py': '/tools/tooltool.py', 07:32:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:32:19 INFO - '/tools/misc-python/virtualenv.py')}, 07:32:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:32:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:32:19 INFO - 'installer_path': 'installer.exe', 07:32:19 INFO - 'log_level': 'info', 07:32:19 INFO - 'log_name': 'talos', 07:32:19 INFO - 'log_to_console': True, 07:32:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:32:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:32:19 INFO - 'opt_config_files': (), 07:32:19 INFO - 'pip_index': False, 07:32:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:32:19 INFO - 'cmd': ('bash', 07:32:19 INFO - '-c', 07:32:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:32:19 INFO - 'enabled': True, 07:32:19 INFO - 'halt_on_failure': False, 07:32:19 INFO - 'name': 'check_screen_resolution'},), 07:32:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:32:19 INFO - 'cmd': ('bash', 07:32:19 INFO - '-c', 07:32:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:32:19 INFO - 'enabled': True, 07:32:19 INFO - 'halt_on_failure': False, 07:32:19 INFO - 'name': 'check_screen_resolution'},), 07:32:19 INFO - 'run_cmd_checks_enabled': True, 07:32:19 INFO - 'sps_profile': False, 07:32:19 INFO - 'sps_profile_interval': 0, 07:32:19 INFO - 'suite': 'dromaeojs-e10s', 07:32:19 INFO - 'system_bits': '32', 07:32:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:32:19 INFO - 'title': 't-yosemite-r7-0085', 07:32:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:32:19 INFO - 'use_talos_json': True, 07:32:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:32:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:32:19 INFO - 'work_dir': 'build'} 07:32:19 INFO - [mozharness: 2016-12-16 15:32:19.398718Z] Running clobber step. 07:32:19 INFO - Running pre-action listener: _resource_record_pre_action 07:32:19 INFO - Running main action method: clobber 07:32:19 INFO - rmtree: /builds/slave/test/build 07:32:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:32:20 INFO - Running post-action listener: _resource_record_post_action 07:32:20 INFO - [mozharness: 2016-12-16 15:32:20.390849Z] Finished clobber step (success) 07:32:20 INFO - [mozharness: 2016-12-16 15:32:20.391060Z] Running read-buildbot-config step. 07:32:20 INFO - Running pre-action listener: _resource_record_pre_action 07:32:20 INFO - Running main action method: read_buildbot_config 07:32:20 INFO - Using buildbot properties: 07:32:20 INFO - { 07:32:20 INFO - "project": "", 07:32:20 INFO - "product": "firefox", 07:32:20 INFO - "script_repo_revision": "production", 07:32:20 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 07:32:20 INFO - "repository": "", 07:32:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 07:32:20 INFO - "buildid": "20161216062349", 07:32:20 INFO - "pgo_build": "False", 07:32:20 INFO - "basedir": "/builds/slave/test", 07:32:20 INFO - "buildnumber": 64, 07:32:20 INFO - "slavename": "t-yosemite-r7-0085", 07:32:20 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:32:20 INFO - "platform": "yosemite_r7", 07:32:20 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:32:20 INFO - "branch": "mozilla-aurora", 07:32:20 INFO - "repo_path": "releases/mozilla-aurora", 07:32:20 INFO - "revision": "ae98ffdc57822f068c011e305ea8a9662dd11e01", 07:32:20 INFO - "stage_platform": "macosx64", 07:32:20 INFO - "builduid": "e22b0ae9dc934263bbd4e58670e869d7", 07:32:20 INFO - "slavebuilddir": "test" 07:32:20 INFO - } 07:32:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/dP5RjLbPReO2SCiNN0UX5A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 07:32:20 INFO - Running post-action listener: _resource_record_post_action 07:32:20 INFO - [mozharness: 2016-12-16 15:32:20.396881Z] Finished read-buildbot-config step (success) 07:32:20 INFO - [mozharness: 2016-12-16 15:32:20.397116Z] Running download-and-extract step. 07:32:20 INFO - Running pre-action listener: _resource_record_pre_action 07:32:20 INFO - Running main action method: download_and_extract 07:32:20 INFO - mkdir: /builds/slave/test/build/tests 07:32:20 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')]} 07:32:20 INFO - trying https://queue.taskcluster.net/v1/task/dP5RjLbPReO2SCiNN0UX5A/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 07:32:20 INFO - Downloading https://queue.taskcluster.net/v1/task/dP5RjLbPReO2SCiNN0UX5A/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 07:32:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dP5RjLbPReO2SCiNN0UX5A/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 07:32:21 INFO - Downloaded 1199 bytes. 07:32:21 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 07:32:21 INFO - Using the following test package requirements: 07:32:21 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 07:32:21 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:32:21 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 07:32:21 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:32:21 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 07:32:21 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:32:21 INFO - u'jsshell-mac.zip'], 07:32:21 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:32:21 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 07:32:21 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 07:32:21 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:32:21 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 07:32:21 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:32:21 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 07:32:21 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:32:21 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 07:32:21 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:32:21 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 07:32:21 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:32:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dP5RjLbPReO2SCiNN0UX5A/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 07:32:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dP5RjLbPReO2SCiNN0UX5A/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:32:21 INFO - Fetch https://queue.taskcluster.net/v1/task/dP5RjLbPReO2SCiNN0UX5A/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 07:32:22 INFO - Http code: 200 07:32:22 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 07:32:22 INFO - x-amz-cf-id: B98KI3U2m03rIP8rg8BYeCZ-_NT2B49RAZSy_w-PtPQISbzt3FzX1A== 07:32:22 INFO - x-amz-version-id: 3Fib7RddHUXyr37F5ydr9j64vvpdssn4 07:32:22 INFO - Expected file size: 16280346 07:32:22 INFO - Obtained file size: 16280346 07:32:29 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 07:32:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dP5RjLbPReO2SCiNN0UX5A/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 07:32:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dP5RjLbPReO2SCiNN0UX5A/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:32:29 INFO - Fetch https://queue.taskcluster.net/v1/task/dP5RjLbPReO2SCiNN0UX5A/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 07:32:29 INFO - Http code: 200 07:32:29 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 07:32:29 INFO - x-amz-cf-id: PoQM7bZvHAFihFxkK9D1-CEO6mzCMDpxZpiqPEDKdceOErYLLREfww== 07:32:29 INFO - x-amz-version-id: 3Fib7RddHUXyr37F5ydr9j64vvpdssn4 07:32:30 INFO - Expected file size: 16280346 07:32:30 INFO - Obtained file size: 16280346 07:32:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dP5RjLbPReO2SCiNN0UX5A/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 07:32:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dP5RjLbPReO2SCiNN0UX5A/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:32:36 INFO - Fetch https://queue.taskcluster.net/v1/task/dP5RjLbPReO2SCiNN0UX5A/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 07:32:37 INFO - Http code: 200 07:32:37 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 07:32:37 INFO - x-amz-cf-id: g4bBrJQY1Na1ML0RVBM76RMbYXqOj2-vJdXNHFNB_xLIhTMX0AWdwQ== 07:32:37 INFO - x-amz-version-id: JCy634WTF8RNu7QXTMwNQhhMeqE2UPH_ 07:32:37 INFO - Expected file size: 14409038 07:32:37 INFO - Obtained file size: 14409038 07:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:37 INFO - trying https://queue.taskcluster.net/v1/task/dP5RjLbPReO2SCiNN0UX5A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:32:37 INFO - Downloading https://queue.taskcluster.net/v1/task/dP5RjLbPReO2SCiNN0UX5A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 07:32:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dP5RjLbPReO2SCiNN0UX5A/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 07:32:40 INFO - Downloaded 109725504 bytes. 07:32:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dP5RjLbPReO2SCiNN0UX5A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:32:40 INFO - mkdir: /builds/slave/test/properties 07:32:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:32:40 INFO - Writing to file /builds/slave/test/properties/build_url 07:32:40 INFO - Contents: 07:32:40 INFO - build_url:https://queue.taskcluster.net/v1/task/dP5RjLbPReO2SCiNN0UX5A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:32:40 INFO - Running post-action listener: _resource_record_post_action 07:32:40 INFO - Running post-action listener: set_extra_try_arguments 07:32:40 INFO - [mozharness: 2016-12-16 15:32:40.997826Z] Finished download-and-extract step (success) 07:32:40 INFO - [mozharness: 2016-12-16 15:32:40.997954Z] Running populate-webroot step. 07:32:40 INFO - Running pre-action listener: _resource_record_pre_action 07:32:40 INFO - Running main action method: populate_webroot 07:32:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:32:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:32:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:32:41 INFO - '--tppagecycles', 07:32:41 INFO - '7'], 07:32:41 INFO - 'tests': ['tsvgm']}}, 07:32:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:32:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:32:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:32:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:32:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:32:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:32:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:41 INFO - 'talos_options': ['--disable-e10s'], 07:32:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:32:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:32:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:41 INFO - 'talos_options': ['--disable-e10s'], 07:32:41 INFO - 'tests': ['damp', 'tps']}, 07:32:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:41 INFO - 'tests': ['damp', 'tps']}, 07:32:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:32:41 INFO - 'tests': ['dromaeo_dom']}, 07:32:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:32:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:32:41 INFO - 'tests': ['basic_compositor_video']}, 07:32:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:32:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:32:41 INFO - 'tests': ['a11yr', 07:32:41 INFO - 'ts_paint', 07:32:41 INFO - 'tpaint', 07:32:41 INFO - 'sessionrestore', 07:32:41 INFO - 'sessionrestore_no_auto_restore', 07:32:41 INFO - 'tabpaint']}, 07:32:41 INFO - 'other-e10s': {'tests': ['a11yr', 07:32:41 INFO - 'ts_paint', 07:32:41 INFO - 'tpaint', 07:32:41 INFO - 'sessionrestore', 07:32:41 INFO - 'sessionrestore_no_auto_restore', 07:32:41 INFO - 'tabpaint']}, 07:32:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:32:41 INFO - 'ts_paint', 07:32:41 INFO - 'tpaint', 07:32:41 INFO - 'sessionrestore', 07:32:41 INFO - 'sessionrestore_no_auto_restore', 07:32:41 INFO - 'tabpaint']}, 07:32:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:32:41 INFO - 'ts_paint', 07:32:41 INFO - 'tpaint', 07:32:41 INFO - 'sessionrestore', 07:32:41 INFO - 'sessionrestore_no_auto_restore', 07:32:41 INFO - 'tabpaint']}, 07:32:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:32:41 INFO - 'tests': ['a11yr', 07:32:41 INFO - 'ts_paint', 07:32:41 INFO - 'tpaint', 07:32:41 INFO - 'sessionrestore', 07:32:41 INFO - 'sessionrestore_no_auto_restore', 07:32:41 INFO - 'tabpaint']}, 07:32:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:32:41 INFO - 'tests': ['a11yr', 07:32:41 INFO - 'ts_paint', 07:32:41 INFO - 'tpaint', 07:32:41 INFO - 'sessionrestore', 07:32:41 INFO - 'sessionrestore_no_auto_restore', 07:32:41 INFO - 'tabpaint']}, 07:32:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:32:41 INFO - 'tests': ['tsvgx', 07:32:41 INFO - 'tsvgr_opacity', 07:32:41 INFO - 'tart', 07:32:41 INFO - 'tscrollx', 07:32:41 INFO - 'cart']}, 07:32:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:32:41 INFO - 'tsvgr_opacity', 07:32:41 INFO - 'tart', 07:32:41 INFO - 'tscrollx', 07:32:41 INFO - 'cart']}, 07:32:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:41 INFO - 'talos_options': ['--disable-e10s'], 07:32:41 INFO - 'tests': ['tp5o']}, 07:32:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:41 INFO - 'tests': ['tp5o']}, 07:32:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:41 INFO - 'talos_options': ['--disable-e10s', 07:32:41 INFO - '--xperf_path', 07:32:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:32:41 INFO - 'tests': ['tp5n']}, 07:32:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:41 INFO - 'talos_options': ['--xperf_path', 07:32:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:32:41 INFO - 'tests': ['tp5n']}}, 07:32:41 INFO - 'talos.zip': {'path': '', 07:32:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:32:41 INFO - Running post-action listener: _resource_record_post_action 07:32:41 INFO - [mozharness: 2016-12-16 15:32:41.016464Z] Finished populate-webroot step (success) 07:32:41 INFO - [mozharness: 2016-12-16 15:32:41.016597Z] Running create-virtualenv step. 07:32:41 INFO - Running pre-action listener: _resource_record_pre_action 07:32:41 INFO - Running main action method: create_virtualenv 07:32:41 INFO - Creating virtualenv /builds/slave/test/build/venv 07:32:41 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 07:32:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:32:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:32:41 INFO - Using real prefix '/tools/python27' 07:32:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:32:41 INFO - Installing distribute.............................................................................................................................................................................................done. 07:32:44 INFO - Installing pip.................done. 07:32:44 INFO - Return code: 0 07:32:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:32:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:32:44 INFO - Reading from file tmpfile_stdout 07:32:44 INFO - Output received: 07:32:44 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) 07:32:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10493d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb49158eed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104751d30>, '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 0x1045b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104749b20>, '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.R4LlZCmSFP/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.tpsZVJBqOr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 07:32:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:32:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:32:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R4LlZCmSFP/Render', 07:32:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:44 INFO - 'HOME': '/Users/cltbld', 07:32:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:44 INFO - 'LOGNAME': 'cltbld', 07:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:44 INFO - 'MOZ_NO_REMOTE': '1', 07:32:44 INFO - 'NO_EM_RESTART': '1', 07:32:44 INFO - 'PAGER': '/bin/cat', 07:32:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:44 INFO - 'PWD': '/builds/slave/test', 07:32:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:44 INFO - 'SHELL': '/bin/bash', 07:32:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tpsZVJBqOr/Listeners', 07:32:44 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 07:32:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:44 INFO - 'USER': 'cltbld', 07:32:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:44 INFO - 'XPC_FLAGS': '0x0', 07:32:44 INFO - 'XPC_SERVICE_NAME': '0', 07:32:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:45 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 07:32:45 INFO - Cleaning up... 07:32:45 INFO - Return code: 0 07:32:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10493d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb49158eed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104751d30>, '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 0x1045b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104749b20>, '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.R4LlZCmSFP/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.tpsZVJBqOr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 07:32:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:32:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:32:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R4LlZCmSFP/Render', 07:32:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:45 INFO - 'HOME': '/Users/cltbld', 07:32:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:45 INFO - 'LOGNAME': 'cltbld', 07:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:45 INFO - 'MOZ_NO_REMOTE': '1', 07:32:45 INFO - 'NO_EM_RESTART': '1', 07:32:45 INFO - 'PAGER': '/bin/cat', 07:32:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:45 INFO - 'PWD': '/builds/slave/test', 07:32:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:45 INFO - 'SHELL': '/bin/bash', 07:32:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tpsZVJBqOr/Listeners', 07:32:45 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 07:32:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:45 INFO - 'USER': 'cltbld', 07:32:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:45 INFO - 'XPC_FLAGS': '0x0', 07:32:45 INFO - 'XPC_SERVICE_NAME': '0', 07:32:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:45 INFO - Downloading/unpacking psutil>=3.1.1 07:32:45 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 07:32:45 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 07:32:45 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 07:32:45 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 07:32:45 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 07:32:45 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 07:32:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:32:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:32:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:32:48 INFO - Installing collected packages: psutil 07:32:48 INFO - Running setup.py install for psutil 07:32:48 INFO - building 'psutil._psutil_osx' extension 07:32:48 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 07:32:49 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 07:32:49 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 07:32:49 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 07:32:49 INFO - building 'psutil._psutil_posix' extension 07:32:49 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 07:32:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:32:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:32:49 INFO - ^ 07:32:49 INFO - 1 warning generated. 07:32:49 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 07:32:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:32:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:32:49 INFO - Successfully installed psutil 07:32:49 INFO - Cleaning up... 07:32:49 INFO - Return code: 0 07:32:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:49 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 0x10493d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb49158eed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104751d30>, '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 0x1045b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104749b20>, '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.R4LlZCmSFP/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.tpsZVJBqOr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 07:32:49 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 07:32:49 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 07:32:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R4LlZCmSFP/Render', 07:32:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:49 INFO - 'HOME': '/Users/cltbld', 07:32:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:49 INFO - 'LOGNAME': 'cltbld', 07:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:49 INFO - 'MOZ_NO_REMOTE': '1', 07:32:49 INFO - 'NO_EM_RESTART': '1', 07:32:49 INFO - 'PAGER': '/bin/cat', 07:32:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:49 INFO - 'PWD': '/builds/slave/test', 07:32:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:49 INFO - 'SHELL': '/bin/bash', 07:32:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tpsZVJBqOr/Listeners', 07:32:49 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 07:32:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:49 INFO - 'USER': 'cltbld', 07:32:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:49 INFO - 'XPC_FLAGS': '0x0', 07:32:49 INFO - 'XPC_SERVICE_NAME': '0', 07:32:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:32:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:32:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:32:52 INFO - Installing collected packages: mozsystemmonitor 07:32:52 INFO - Running setup.py install for mozsystemmonitor 07:32:52 INFO - Successfully installed mozsystemmonitor 07:32:52 INFO - Cleaning up... 07:32:52 INFO - Return code: 0 07:32:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:32:52 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')]} 07:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:52 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')]} 07:32:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:52 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 0x10493d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb49158eed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104751d30>, '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 0x1045b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104749b20>, '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.R4LlZCmSFP/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.tpsZVJBqOr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 07:32:52 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 07:32:52 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 07:32:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R4LlZCmSFP/Render', 07:32:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:52 INFO - 'HOME': '/Users/cltbld', 07:32:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:52 INFO - 'LOGNAME': 'cltbld', 07:32:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:52 INFO - 'MOZ_NO_REMOTE': '1', 07:32:52 INFO - 'NO_EM_RESTART': '1', 07:32:52 INFO - 'PAGER': '/bin/cat', 07:32:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:52 INFO - 'PWD': '/builds/slave/test', 07:32:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:52 INFO - 'SHELL': '/bin/bash', 07:32:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tpsZVJBqOr/Listeners', 07:32:52 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 07:32:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:52 INFO - 'USER': 'cltbld', 07:32:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:52 INFO - 'XPC_FLAGS': '0x0', 07:32:52 INFO - 'XPC_SERVICE_NAME': '0', 07:32:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:53 INFO - Downloading/unpacking jsonschema==2.5.1 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32: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 07:32:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:32:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:32:55 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 07:32:55 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 07:32:55 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 07:32:55 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 07:32:55 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 07:32:55 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 07:32:56 INFO - Downloading functools32-3.2.3-2.tar.gz 07:32:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:32:56 INFO - warning: no files found matching '*.txt' 07:32:56 INFO - no previously-included directories found matching 'build' 07:32:56 INFO - no previously-included directories found matching 'dist' 07:32:56 INFO - no previously-included directories found matching '.git*' 07:32:56 INFO - Installing collected packages: jsonschema, functools32 07:32:56 INFO - Running setup.py install for functools32 07:32:56 INFO - warning: no files found matching '*.txt' 07:32:56 INFO - no previously-included directories found matching 'build' 07:32:56 INFO - no previously-included directories found matching 'dist' 07:32:56 INFO - no previously-included directories found matching '.git*' 07:32:56 INFO - Successfully installed jsonschema functools32 07:32:56 INFO - Cleaning up... 07:32:56 INFO - Return code: 0 07:32:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10493d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb49158eed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104751d30>, '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 0x1045b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104749b20>, '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.R4LlZCmSFP/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.tpsZVJBqOr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 07:32:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:32:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R4LlZCmSFP/Render', 07:32:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:56 INFO - 'HOME': '/Users/cltbld', 07:32:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:56 INFO - 'LOGNAME': 'cltbld', 07:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:56 INFO - 'MOZ_NO_REMOTE': '1', 07:32:56 INFO - 'NO_EM_RESTART': '1', 07:32:56 INFO - 'PAGER': '/bin/cat', 07:32:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:56 INFO - 'PWD': '/builds/slave/test', 07:32:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:56 INFO - 'SHELL': '/bin/bash', 07:32:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tpsZVJBqOr/Listeners', 07:32:56 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 07:32:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:56 INFO - 'USER': 'cltbld', 07:32:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:56 INFO - 'XPC_FLAGS': '0x0', 07:32:56 INFO - 'XPC_SERVICE_NAME': '0', 07:32:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:32:56 INFO - Cleaning up... 07:32:56 INFO - Return code: 0 07:32:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10493d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb49158eed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104751d30>, '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 0x1045b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104749b20>, '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.R4LlZCmSFP/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.tpsZVJBqOr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 07:32:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:32:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R4LlZCmSFP/Render', 07:32:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:56 INFO - 'HOME': '/Users/cltbld', 07:32:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:56 INFO - 'LOGNAME': 'cltbld', 07:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:56 INFO - 'MOZ_NO_REMOTE': '1', 07:32:56 INFO - 'NO_EM_RESTART': '1', 07:32:56 INFO - 'PAGER': '/bin/cat', 07:32:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:56 INFO - 'PWD': '/builds/slave/test', 07:32:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:56 INFO - 'SHELL': '/bin/bash', 07:32:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tpsZVJBqOr/Listeners', 07:32:56 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 07:32:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:56 INFO - 'USER': 'cltbld', 07:32:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:56 INFO - 'XPC_FLAGS': '0x0', 07:32:56 INFO - 'XPC_SERVICE_NAME': '0', 07:32:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:57 INFO - Downloading/unpacking blobuploader==1.2.4 07:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:59 INFO - Downloading blobuploader-1.2.4.tar.gz 07:32:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:32:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:32:59 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 07:32:59 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 07:32:59 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 07:32:59 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 07:32:59 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 07:32:59 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 07:33:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:33:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:33:00 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 07:33:00 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 07:33:00 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 07:33:00 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 07:33:00 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 07:33:00 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 07:33:00 INFO - Downloading docopt-0.6.1.tar.gz 07:33:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:33:01 INFO - Installing collected packages: blobuploader, requests, docopt 07:33:01 INFO - Running setup.py install for blobuploader 07:33:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:33:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:33:01 INFO - Running setup.py install for requests 07:33:01 INFO - Running setup.py install for docopt 07:33:01 INFO - Successfully installed blobuploader requests docopt 07:33:01 INFO - Cleaning up... 07:33:01 INFO - Return code: 0 07:33:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:33:01 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')]} 07:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:01 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')]} 07:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:01 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 0x10493d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb49158eed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104751d30>, '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 0x1045b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104749b20>, '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.R4LlZCmSFP/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.tpsZVJBqOr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 07:33:01 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 07:33:01 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 07:33:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R4LlZCmSFP/Render', 07:33:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:01 INFO - 'HOME': '/Users/cltbld', 07:33:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:01 INFO - 'LOGNAME': 'cltbld', 07:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:01 INFO - 'MOZ_NO_REMOTE': '1', 07:33:01 INFO - 'NO_EM_RESTART': '1', 07:33:01 INFO - 'PAGER': '/bin/cat', 07:33:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:01 INFO - 'PWD': '/builds/slave/test', 07:33:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:01 INFO - 'SHELL': '/bin/bash', 07:33:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tpsZVJBqOr/Listeners', 07:33:01 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 07:33:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:01 INFO - 'USER': 'cltbld', 07:33:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:01 INFO - 'XPC_FLAGS': '0x0', 07:33:01 INFO - 'XPC_SERVICE_NAME': '0', 07:33:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:33:02 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-Rr9cgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:33:02 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-0VfQcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:33:02 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-zELZUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:33:02 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-FW1vhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:33:02 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-PqRE5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:33:02 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-YACYZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:33:02 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-3gb7s6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:33:02 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-S_X2nX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:33:03 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-684iDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:33:03 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-QMqb9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:33:03 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-_I9wrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:33:03 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-pnvljg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:33:03 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-0TdEAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:33:03 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-kWY2ku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:33:03 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-F2NK9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:33:03 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-3Apj9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:33:03 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-pn7Sr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:33:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:33:03 INFO - Running setup.py install for manifestparser 07:33:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:33:04 INFO - Running setup.py install for mozcrash 07:33:04 INFO - Running setup.py install for mozdebug 07:33:04 INFO - Running setup.py install for mozdevice 07:33:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:33:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:33:04 INFO - Running setup.py install for mozfile 07:33:04 INFO - Running setup.py install for mozhttpd 07:33:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:33:04 INFO - Running setup.py install for mozinfo 07:33:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:33:05 INFO - Running setup.py install for mozInstall 07:33:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:33:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:33:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:33:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:33:05 INFO - Running setup.py install for mozleak 07:33:05 INFO - Running setup.py install for mozlog 07:33:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:33:05 INFO - Running setup.py install for moznetwork 07:33:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:33:05 INFO - Running setup.py install for mozprocess 07:33:05 INFO - Running setup.py install for mozprofile 07:33:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:33:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:33:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:33:05 INFO - Running setup.py install for mozrunner 07:33:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:33:06 INFO - Running setup.py install for mozscreenshot 07:33:06 INFO - Running setup.py install for moztest 07:33:06 INFO - Running setup.py install for mozversion 07:33:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:33:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:33:06 INFO - Cleaning up... 07:33:06 INFO - Return code: 0 07:33:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:33: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')]} 07:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33: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')]} 07:33:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:06 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 0x10493d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb49158eed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104751d30>, '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 0x1045b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104749b20>, '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.R4LlZCmSFP/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.tpsZVJBqOr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 07:33:06 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 07:33:06 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 07:33:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R4LlZCmSFP/Render', 07:33:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:06 INFO - 'HOME': '/Users/cltbld', 07:33:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:06 INFO - 'LOGNAME': 'cltbld', 07:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:06 INFO - 'MOZ_NO_REMOTE': '1', 07:33:06 INFO - 'NO_EM_RESTART': '1', 07:33:06 INFO - 'PAGER': '/bin/cat', 07:33:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:06 INFO - 'PWD': '/builds/slave/test', 07:33:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:06 INFO - 'SHELL': '/bin/bash', 07:33:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tpsZVJBqOr/Listeners', 07:33:06 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 07:33:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:06 INFO - 'USER': 'cltbld', 07:33:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:06 INFO - 'XPC_FLAGS': '0x0', 07:33:06 INFO - 'XPC_SERVICE_NAME': '0', 07:33:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:33:06 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-MFrG1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:33:06 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)) 07:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:33:06 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-FC1h5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:33:07 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)) 07:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:33:07 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-4Yt8fn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:33:07 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)) 07:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:33:07 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-g4MF2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:33:07 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)) 07:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:33:07 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-N38gwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:33:07 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)) 07:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:33:07 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-mfiuJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:33:07 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)) 07:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:33:07 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-hVB5o2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:33:07 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)) 07:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:33:07 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-EhDazu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:33:07 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)) 07:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:33:07 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-cAkSjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:33:07 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)) 07:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:33:07 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-A0vin4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:33:07 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)) 07:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:33:07 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-jt0Dgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:33:07 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)) 07:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:33:07 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-sJTWvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:33:08 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)) 07:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:33:08 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-0Ea8CX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:33:08 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)) 07:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:33:08 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-GafOQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:33:08 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)) 07:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:33:08 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-MseB8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:33:08 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)) 07:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:33:08 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-e9aXY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:33:08 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-Y9Q8aO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:33:08 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)) 07:33:08 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)) 07:33:08 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)) 07:33:08 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)) 07:33:08 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)) 07:33:08 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)) 07:33:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:33:08 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 07:33:08 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 07:33:08 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 07:33:08 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 07:33:08 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 07:33:08 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 07:33:11 INFO - Downloading blessings-1.6.tar.gz 07:33:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:33:11 INFO - Installing collected packages: blessings 07:33:11 INFO - Running setup.py install for blessings 07:33:11 INFO - Successfully installed blessings 07:33:11 INFO - Cleaning up... 07:33:11 INFO - Return code: 0 07:33:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:33:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:33:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:33:11 INFO - Reading from file tmpfile_stdout 07:33:11 INFO - Current package versions: 07:33:11 INFO - blessings == 1.6 07:33:11 INFO - blobuploader == 1.2.4 07:33:11 INFO - docopt == 0.6.1 07:33:11 INFO - functools32 == 3.2.3-2 07:33:11 INFO - jsonschema == 2.5.1 07:33:11 INFO - manifestparser == 1.1 07:33:11 INFO - mozInstall == 1.12 07:33:11 INFO - mozcrash == 1.0 07:33:11 INFO - mozdebug == 0.1 07:33:11 INFO - mozdevice == 0.48 07:33:11 INFO - mozfile == 1.2 07:33:11 INFO - mozhttpd == 0.7 07:33:11 INFO - mozinfo == 0.9 07:33:11 INFO - mozleak == 0.1 07:33:11 INFO - mozlog == 3.4 07:33:11 INFO - moznetwork == 0.27 07:33:11 INFO - mozprocess == 0.23 07:33:11 INFO - mozprofile == 0.28 07:33:11 INFO - mozrunner == 6.13 07:33:11 INFO - mozscreenshot == 0.1 07:33:11 INFO - mozsystemmonitor == 0.3 07:33:11 INFO - moztest == 0.7 07:33:11 INFO - mozversion == 1.4 07:33:11 INFO - psutil == 3.1.1 07:33:11 INFO - requests == 1.2.3 07:33:11 INFO - wsgiref == 0.1.2 07:33:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:33:11 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')]} 07:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:11 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')]} 07:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:11 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 0x10493d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb49158eed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104751d30>, '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 0x1045b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104749b20>, '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.R4LlZCmSFP/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.tpsZVJBqOr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 07:33:11 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 07:33:11 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 07:33:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R4LlZCmSFP/Render', 07:33:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:11 INFO - 'HOME': '/Users/cltbld', 07:33:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:11 INFO - 'LOGNAME': 'cltbld', 07:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:11 INFO - 'MOZ_NO_REMOTE': '1', 07:33:11 INFO - 'NO_EM_RESTART': '1', 07:33:11 INFO - 'PAGER': '/bin/cat', 07:33:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:11 INFO - 'PWD': '/builds/slave/test', 07:33:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:11 INFO - 'SHELL': '/bin/bash', 07:33:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tpsZVJBqOr/Listeners', 07:33:11 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 07:33:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:11 INFO - 'USER': 'cltbld', 07:33:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:11 INFO - 'XPC_FLAGS': '0x0', 07:33:11 INFO - 'XPC_SERVICE_NAME': '0', 07:33:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:12 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)) 07:33:12 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)) 07:33:12 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)) 07:33:12 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)) 07:33:12 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)) 07:33:12 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)) 07:33:12 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)) 07:33:12 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)) 07:33:12 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)) 07:33:12 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)) 07:33:12 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)) 07:33:12 INFO - Cleaning up... 07:33:12 INFO - Return code: 0 07:33:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:33:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:12 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 0x10493d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb49158eed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104751d30>, '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 0x1045b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104749b20>, '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.R4LlZCmSFP/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.tpsZVJBqOr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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 07:33:12 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 07:33:12 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 07:33:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R4LlZCmSFP/Render', 07:33:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:12 INFO - 'HOME': '/Users/cltbld', 07:33:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:12 INFO - 'LOGNAME': 'cltbld', 07:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:12 INFO - 'MOZ_NO_REMOTE': '1', 07:33:12 INFO - 'NO_EM_RESTART': '1', 07:33:12 INFO - 'PAGER': '/bin/cat', 07:33:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:12 INFO - 'PWD': '/builds/slave/test', 07:33:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:12 INFO - 'SHELL': '/bin/bash', 07:33:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tpsZVJBqOr/Listeners', 07:33:12 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 07:33:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:12 INFO - 'USER': 'cltbld', 07:33:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:12 INFO - 'XPC_FLAGS': '0x0', 07:33:12 INFO - 'XPC_SERVICE_NAME': '0', 07:33:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:33:12 INFO - Cleaning up... 07:33:12 INFO - Return code: 0 07:33:12 INFO - Running post-action listener: _resource_record_post_action 07:33:12 INFO - Running post-action listener: _start_resource_monitoring 07:33:12 INFO - Starting resource monitoring. 07:33:12 INFO - [mozharness: 2016-12-16 15:33:12.406736Z] Finished create-virtualenv step (success) 07:33:12 INFO - [mozharness: 2016-12-16 15:33:12.407775Z] Running install step. 07:33:12 INFO - Running pre-action listener: _resource_record_pre_action 07:33:12 INFO - Running main action method: install 07:33:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:33:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:33:12 INFO - Reading from file tmpfile_stdout 07:33:12 INFO - Detecting whether we're running mozinstall >=1.0... 07:33:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:33:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:33:12 INFO - Reading from file tmpfile_stdout 07:33:12 INFO - Output received: 07:33:12 INFO - Usage: mozinstall [options] installer 07:33:12 INFO - Options: 07:33:12 INFO - -h, --help show this help message and exit 07:33:12 INFO - -d DEST, --destination=DEST 07:33:12 INFO - Directory to install application into. [default: 07:33:12 INFO - "/builds/slave/test"] 07:33:12 INFO - --app=APP Application being installed. [default: firefox] 07:33:12 INFO - mkdir: /builds/slave/test/build/application 07:33:12 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'] 07:33:12 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 07:33:43 INFO - Reading from file tmpfile_stdout 07:33:43 INFO - Output received: 07:33:43 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:33:43 INFO - Running post-action listener: _resource_record_post_action 07:33:43 INFO - [mozharness: 2016-12-16 15:33:43.747560Z] Finished install step (success) 07:33:43 INFO - [mozharness: 2016-12-16 15:33:43.747722Z] Running run-tests step. 07:33:43 INFO - Running pre-action listener: _resource_record_pre_action 07:33:43 INFO - Running main action method: run_tests 07:33:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:33:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:33:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:33:43 INFO - 2016-12-16 07:33:43.762 screenresolution[1991:15755] starting screenresolution argv=screenresolution get 07:33:43 INFO - 2016-12-16 07:33:43.764 screenresolution[1991:15755] Display 0: 1600x1200x32@60 07:33:43 INFO - 2016-12-16 07:33:43.770 screenresolution[1992:15758] starting screenresolution argv=screenresolution list 07:33:43 INFO - Available Modes on Display 0 07:33:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:33:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:33:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:33:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:33:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:33:43 INFO - Intel Iris: 07:33:43 INFO - Chipset Model: Intel Iris 07:33:43 INFO - Type: GPU 07:33:43 INFO - Bus: Built-In 07:33:43 INFO - VRAM (Dynamic, Max): 1536 MB 07:33:43 INFO - Vendor: Intel (0x8086) 07:33:43 INFO - Device ID: 0x0a2e 07:33:43 INFO - Revision ID: 0x0009 07:33:43 INFO - Displays: 07:33:43 INFO - Display: 07:33:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:33:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:33:43 INFO - Display Serial Number: 1600x1200 60 07:33:43 INFO - Main Display: Yes 07:33:44 INFO - Mirror: Off 07:33:44 INFO - Online: Yes 07:33:44 INFO - Rotation: Supported 07:33:44 INFO - Return code: 0 07:33:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:33:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:33:44 INFO - Python 2.7.3 07:33:44 INFO - Return code: 0 07:33:44 INFO - grabbing minidump binary from tooltool 07:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:44 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 0x104751d30>, '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 0x1045b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104749b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:33:44 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 07:33:44 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 07:33:44 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 07:33:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:33:44 INFO - Return code: 0 07:33:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:33:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:33:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:33:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:33:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:33:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dP5RjLbPReO2SCiNN0UX5A/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0085', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:33:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dP5RjLbPReO2SCiNN0UX5A/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0085 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:33:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.R4LlZCmSFP/Render', 07:33:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:44 INFO - 'HOME': '/Users/cltbld', 07:33:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:44 INFO - 'LOGNAME': 'cltbld', 07:33:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:33:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:33:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:44 INFO - 'MOZ_NO_REMOTE': '1', 07:33:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:33:44 INFO - 'NO_EM_RESTART': '1', 07:33:44 INFO - 'PAGER': '/bin/cat', 07:33:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:44 INFO - 'PWD': '/builds/slave/test', 07:33:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:33:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:44 INFO - 'SHELL': '/bin/bash', 07:33:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tpsZVJBqOr/Listeners', 07:33:44 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 07:33:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:44 INFO - 'USER': 'cltbld', 07:33:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:44 INFO - 'XPC_FLAGS': '0x0', 07:33:44 INFO - 'XPC_SERVICE_NAME': '0', 07:33:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dP5RjLbPReO2SCiNN0UX5A/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0085', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:33:44 INFO - mozversion application_buildid: 20161216062349 07:33:44 INFO - mozversion application_changeset: ae98ffdc57822f068c011e305ea8a9662dd11e01 07:33:44 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:33:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:33:44 INFO - mozversion application_name: Firefox 07:33:44 INFO - mozversion application_remotingname: firefox-dev 07:33:44 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:33:44 INFO - mozversion application_vendor: Mozilla 07:33:44 INFO - mozversion application_version: 52.0a2 07:33:44 INFO - mozversion platform_buildid: 20161216062349 07:33:44 INFO - mozversion platform_changeset: ae98ffdc57822f068c011e305ea8a9662dd11e01 07:33:44 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:33:44 INFO - mozversion platform_version: 52.0a2 07:33:44 INFO - using testdate: 1481902424 07:33:44 INFO - actual date: 1481902424 07:33:44 INFO - starting webserver on 'localhost:51293' 07:33:44 INFO - SUITE-START | Running 2 tests 07:33:44 INFO - TEST-START | dromaeo_css 07:33:44 INFO - operating with platform_type : mac_ 07:33:44 INFO - Initialising browser for dromaeo_css test... 07:33:44 INFO - TEST-INFO | started process 2002 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpC5crPd/profile http://localhost:51293/getInfo.html) 07:33:47 INFO - PROCESS | 2002 | 2016-12-16 07:33:47.404 plugin-container[2004:15924] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3f, name = 'com.apple.tsm.portname' 07:33:47 INFO - PROCESS | 2002 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:33:47 INFO - PROCESS | 2002 | 2016-12-16 07:33:47.407 plugin-container[2004:15924] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 07:33:47 INFO - PROCESS | 2002 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:33:47 INFO - PROCESS | 2002 | 2016-12-16 07:33:47.407 plugin-container[2004:15924] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:33:47 INFO - PROCESS | 2002 | __metrics Screen width/height:1600/1200 07:33:47 INFO - PROCESS | 2002 | colorDepth:24 07:33:47 INFO - PROCESS | 2002 | Browser inner width/height: 1024/689 07:33:47 INFO - PROCESS | 2002 | __metrics 07:33:47 ERROR - PROCESS | 2002 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 07:33:48 INFO - TEST-INFO | 2002: exit 0 07:33:48 INFO - Browser initialized. 07:33:48 INFO - Running cycle 1/1 for dromaeo_css test... 07:33:48 INFO - TEST-INFO | started process 2005 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpC5crPd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:33:51 INFO - PROCESS | 2005 | 2016-12-16 07:33:51.160 plugin-container[2006:16051] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843b, name = 'com.apple.tsm.portname' 07:33:51 INFO - PROCESS | 2005 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:33:51 INFO - PROCESS | 2005 | 2016-12-16 07:33:51.161 plugin-container[2006:16051] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4507, name = 'com.apple.CFPasteboardClient' 07:33:51 INFO - PROCESS | 2005 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:33:51 INFO - PROCESS | 2005 | 2016-12-16 07:33:51.161 plugin-container[2006:16051] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:34:00 INFO - PROCESS | 2005 | RSS: Main: 229748736 07:34:00 INFO - PROCESS | 2005 | 07:34:50 INFO - PROCESS | 2005 | 1481902490489 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:37:04 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:51293/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51293/tests/dromaeo/cssquery-ext.html) 07:37:06 INFO - PROCESS | 2005 | RSS: Main: 232087552 07:37:06 INFO - PROCESS | 2005 | 07:40:08 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:51293/tests/dromaeo/cssquery-ext.html (next: http://localhost:51293/tests/dromaeo/cssquery-jquery.html) 07:40:09 INFO - PROCESS | 2005 | RSS: Main: 243261440 07:40:09 INFO - PROCESS | 2005 | 07:43:11 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:51293/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51293/tests/dromaeo/cssquery-mootools.html) 07:43:12 INFO - PROCESS | 2005 | RSS: Main: 246566912 07:43:12 INFO - PROCESS | 2005 | 07:46:14 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:51293/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51293/tests/dromaeo/cssquery-prototype.html) 07:46:14 INFO - PROCESS | 2005 | RSS: Main: 245309440 07:46:14 INFO - PROCESS | 2005 | 07:49:17 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:51293/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51293/tests/dromaeo/cssquery-yui.html) 07:49:18 INFO - PROCESS | 2005 | RSS: Main: 249843712 07:49:18 INFO - PROCESS | 2005 | 07:52:20 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:51293/tests/dromaeo/cssquery-yui.html (next: http://localhost:51293/tests/dromaeo/cssquery-dojo.html) 07:52:21 INFO - PROCESS | 2005 | RSS: Main: 251375616 07:52:21 INFO - PROCESS | 2005 | 07:52:21 INFO - PROCESS | 2005 | __start_tp_report 07:52:21 INFO - PROCESS | 2005 | _x_x_mozilla_page_load 07:52:21 INFO - PROCESS | 2005 | _x_x_mozilla_page_load_details 07:52:21 INFO - PROCESS | 2005 | |i|pagename|runs| 07:52:21 INFO - PROCESS | 2005 | |0;dojo.html;3430.554027976363;3434.2272988577574;3439.4496880499123;3443.208062145708;3477.1654802847324;5906.70466476676;5922.733476993535;5927.170196172534;5937.792177273796;5963.463288304052;5916.8224953251365;5957.225560677106;5997.910031349522;6009.4291042351015;6016.849578760533;5024.84925452237;5331.840044798662;5421.241026256327;5429.647072940266;5457.454254574551;5409.29679141711;5421.810236641718;5440.972795136019;5443.156310771837;5481.972590137044;5338.706371149585;5357.330333708286;5438.972805135969;5459.563234941215;5508.779648814043;4335.84824531143;4526.275795872661;5366.570674346043;5430.56555475563;5452.836414907559;5284.392294886099;5416.458354164552;5434.103372943459;5461.9453805461835;5482.17767334899;5476.808311709111;5912.320083190445;6041.939580604182;6065.636061836304;6090.177825993478;5209.453007434203;6182.412670796267;6227.221597300338;6231.968840155816;6257.405546473078;6229.034499652561;6268.78059267928;6306.653134077624;6346.87306253877;6363.713632886485;6066.181065556138;6066.969665151734;6070.7875224366935;6075.48358389533;6078.088286757022;6439.291677915426;6441.871162576722;6486.221653401528;6524.869502610016;6529.2817790043055;6144.969275153596;6173.567850250529;6176.104464852661;6225.595336303126;6239.344868788712;6254.405831446005;6285.151504546919;6321.399467050623;6332.8416789579705;6359.777407790798;6243.719032643542;6251.187345645037;6270.372962703785;6281.214848143982;6286.339934306923;6182.907256391158;6300.527460440485;6308.684565771785;6316.747330106836;6317.46301564363;4986.850394488171;4999.200127979506;5023.095842748267;5029.497050294941;5035.899282014412;4431.290993441034;4435.689501734848;4499.235130027903;4499.280115181556;4513.774311284423;5320.494553017457;5393.7572809223675;6052.606580572248;6086.360932102154;6136.539759518054;6359.96820015897;6370.394812492806;6374.298827129012;6379.011253255753;6383.6488993104895;5953.077273022688;6003.939960600425;6004.42957918997;6012.518998480111;6038.698065096728;5550.72246387679;5559.833205003856;5570.749316280777;5586.273784408001;5619.887602247933;6494.383033611799;6526.4452521536205;6531.771388001397;6535.0850880876715;6538.673066346663;6140.412224875342;6205.596636218631;6235.844103897258;6306.148669929685;6374;5332.840014799563;5356.625036247426;6522.445592124533;6531.085648009187;6549.148610680581;6252.781152659635;6256.812295631138;6274.623522588659;6276.278228003838;6287.434130928238;6128.717018009172;6155.230596175478;6220.284667263322;6312.43188113072;6314.052892066226;6130.336988992987;6165.475934545434;6167.229096362955;6219.844503887439;6262.373762623702;5161.587073034073;5181.870453238699;6227.688615569113;6231.626102433868;6249.218847644044;5634.802781902614;5991.730372133177;6061.666608336407;6190.938090619036;6222.471089957405;5666.065099258741;6155.96922015405;6158.414950579688;6164.321924588381;6181.196444462191;6040.516758659384;6054.788082417094;6113.57204995646;6120.296165940974;6148.754049838135 07:52:21 INFO - PROCESS | 2005 | |1;ext.html;454.6908102490305;465.4228756342136;467.3480494709882;514.2851436503261;521.6504941689068;28579;39236.60763392365;40198.79900600496;40240.79879600605;40317.596824031825;41152.971175720544;41566.79216603913;41602.58397416025;41676.791616041955;41763;9364.250859931206;9526.190273826733;9547.713568592953;9551.761205969837;9574.760630984212;9380.765480862965;9457.62169513222;9477.47873866937;9487.857682134774;9505.429674219535;9484.051594840495;9519.714408567754;9522.80954380912;9549.809003819919;9573.712788616353;9465.716028519155;9488.715338539854;9489.715308540686;9491.715248542485;9518.476483793389;9322.25421966241;9426.434413935185;9435.339526233167;9454.810903781954;9467.857982130274;33928.660713393045;39075.60924390748;39267.8036609818;39406.80296598528;39463.60536394628;3341.899743007714;3344.916377090592;3453.2230248194205;3847.03824043989;4000.3399439092514;29048.56427153573;29577.408451830845;29716.405671886656;29805.850970745225;29887.850560747058;2986.8655910483862;3076.492378757502;3104.3170502489415;3107.052349033544;3107.984460077685;417596;493628;499077.50461247825;501850;504811;61818;61933;62194.37805621886;62314.376856231764;62394.0640890387;65198.674006630616;65655.70205042801;65827.67086164538;65855.67072164704;65926.34073659297;16090.034597924163;16320.102394368187;16322.428714994918;16337.591560210853;16365.099919504542;12344.012479001658;12407.193532420364;12430.316332601613;12491.312977786127;12546.87453125457;15082.54752357431;16817.243224054702;18992.525186870163;19017;19074.713879291823;5962.940370596325;6806.353396427331;6938.757143499954;7234.674439650228;7276.745313913988;714.4391652552721;829.8298848735994;959.7024922274118;960.3373672166183;1015.9441230732381;24016.51966960651;29699;29785;29948.251293717833;30348.393032139233;809.4738420026912;906.918377346042;1054.8048611006989;1067;1075.3762817565794;12217.877821221675;14218.28908554568;15461.84538154604;15486.225688715744;15835.762463563056;519136;638665;645756;652025;652728;55895.16157257644;56499.71750141223;56654.15018774722;57093.143602845994;57211;1336.4253371050543;1353.9661508462368;1382.5092092307286;1382.9446822127002;1384.847666756656;28723;29305;29385.559216612197;29426.411471770873;29804.552931706476;50027.499725002286;50175.494735158005;50321.49678503168;50484.747576261885;50616.24075638942;504947;511556;513633;513750;517111.41444292536;26047.479050419264;26250.60624090602;26579.069732559266;26689.199324020312;26789.86605066962;45200.77399612981;45279.54720452885;45622.771886140355;46060.30909536293;46545;37274;38080.61919380771;38653.613463865004;39198.82403527899;40806.57176998791;32477.51283730793;37690.811545942095;37834.62165378311;37974.810125949196;39033.80483097566;37751.81124094362;38112.809435952644;38413;38713.4192987111;38824.6117538821;32813.343733124726;34513.30973380468;34527;34665.960021199404;34988;25877.870610646827;25968.8701556491;26010.60984085278;26117.216483505526;26230.58477030131 07:52:21 INFO - PROCESS | 2005 | |2;jquery.html;368.6995098994318;371.15006634806286;383.04812540836025;385.753118004477;399.85405327055616;17707.55731106723;19142;19776.505587360323;19805.702914456277;19998.500037499034;16586.917065414655;18777.15502802374;18877.905610471964;19210.327638532654;19237.519062023457;4293.506246781629;5279.5512381447625;5458.918116228259;5462.962037212937;5497.202905578689;4852.49048849871;5273.841784746463;5324.174752913285;5387.299651045379;5394.676319420828;5382.2195781611645;5392.083345831218;5393.514583687467;5397.973010134944;5592.7762889484375;5796.30444346679;5800.796972105956;5927.585069045147;5937.109433584954;5940.70296485174;5317.707526086064;5343.759530821122;5396.541293990015;5732.0542110551705;5736.627119237278;12897.484100635964;13073;13121.737565248737;13130.803037954438;17593;2050.6103840270302;2274.363178310059;2306.953860922772;2399.4121440247077;2666.520026395248;9818.950905245429;10224.386536807815;10262.973702629752;10323.79352412955;14396.64008399788;1516.5222954769213;1840;1860.9348672796386;1879.755631767875;1889.2726300374318;111319;112749.87250127476;123199;125569;128540.35729821384;11242.831357529643;11245.775084498264;11466.08271338291;11807.992641251009;11938.28370297785;14631.707365852624;14688.55934321972;14691.55925322242;14727.779083313759;14730.852691472948;7279.053723015974;8228.42401031922;8389;8469.068402475723;8559.657613695506;7950.960245198737;8052.194780521901;8178.836423271501;8389;8392.244697977212;4139.3583994480905;4554.63562914966;4598.333241680005;4612.262038073892;4615.263137115543;1909.303104366924;1943.4655469745933;1957.8629495935434;1990.5421752996601;1999.8200161985492;732.9303716146958;865.1910463716446;866.4368160695473;914.0767824497173;978.3933960944261;20338.79661203369;20640.27759028427;21134.260300889397;21567.56864862694;21640.891795541236;893.7586851550045;915.1443400420628;917.8898532176048;958.3674774648698;962.9759256018516;10703.876093010278;10825.512851921683;10862.721976275914;11063.668089957315;11148.554057837595;245560;246021;246238;247600.76199618887;247842;72409;101117;101659;120295.39852300682;125150.37424812818;948.4072454715803;963.9036096390305;993.4536005197112;993.9155171810477;994.6476582881434;14840.332185051482;18816.24735010584;18891.43325700231;19044.904775476032;19093.331733389266;55995;57374.7131264341;58065.419345806;58082.4191758077;58121.418785813294;79605;79993;82200.58899705463;82485.17514824776;83840.58079709562;7859.331956783737;8045.477043992122;8094.271515563628;8111.4321997461975;8122.309603683753;8766.123387661182;11517.884821151682;12523.686907827378;12572.748545028866;12717;8710.041895391629;10137.391756494633;10613.363198208132;10980.396078215776;11101.333919964827;10458.58165673395;10785.029347358775;10801.729956751144;10943.726406839893;11052.336859788438;10376.584936602754;11150.721231969266;11182.888171118184;11318.377489238172;11497.655070347902;7796.181400952818;7981.680732770624;8090.838183236185;8227.053888802864;8434.198751118634;8303.294219991369;10438.843417348899;11023.724406889893;11079.612213572485;11086.946740059682 07:52:21 INFO - PROCESS | 2005 | |3;mootools.html;1169.4445138559183;1305.627896049626;1535.0942943663244;1764.082677007955;1797.0206237600498;6780.9321906780915;7571.205023472525;7855.978722766033;8532.402731808776;8556.016058153315;8064.71773487928;8358.874616880752;8405.033421156553;8450.57747112645;8506;1914.904254787262;2355.693759811222;2359.091749676378;2362.2086600988605;2371.537550177716;2327.173853282086;2363.231949616373;2381.2856143156982;2381.630847218675;2386.164842305188;2161.6273666221905;2196.253273886878;2325.7557956414585;2331.172433786007;2350.048230466664;2310.572544079351;2314.5370925814905;2334.159702507096;2338.684277622516;2344.2615576093476;2337.7077865266842;2358.13927916311;2358.8348815582917;2362.503874186406;2366.7041619797524;8420.073791882887;8445.746627601182;8473.322134229247;8489.320854331638;8490.915090849074;5091;5228;5259.053370393328;5271.525562699337;5280.260763493114;3321.3191295784304;3456.4988076728987;3533.7703049301713;3621.022323972513;3623.601403845575;1035.2339268941005;1054.510936124378;1071.7695695425443;1086.625114335561;1086.7174534620976;10853.728656783565;10892.128629709605;10945.90540945907;11002.50488728009;11073.224874258805;4535.682502224812;4652.95347046532;4717.292406139038;4733.171694953369;4801.735904525284;8014.398920081017;9529.332946693665;9543.761405964768;9559.665411710557;9568.186704130088;5243.10867152585;5258.973705131526;5261.76322065508;5276.577873770089;5279.313689220454;4105.281575724236;4740.312654665055;4749.4775574686755;4777.474477807438;4843.055604157226;3828.406596977473;3835.290471262825;3907.4529565860803;3944.9013774655864;3946.8026598669953;1016.8373060310315;1162.7093226693328;1272.2748033620746;1278.7314663920681;1289.2006955687534;759.6429678051308;852.6333676519032;893.5755516129916;896.9282457403392;911.9635214591475;5585.273914391103;5654.9151762723595;5688.886222275614;5726.4559866813415;5873.177755114288;895.3598177303129;906.2749800159977;936.2509992006504;951.410125722043;952.8999455057258;3709.146896213886;3805.0487378155462;3846.076941534012;3856.36369998947;3925.784081875467;8489.95755021221;9870.654527091518;10126.481027845883;10283.43441110746;10287.639932602324;7175.282471752783;10064.043915827984;10075.899241007643;10212.489375531193;10229.386236825814;7643.044619422572;7835.0597928247835;7850.097238817495;7852.921470785333;7874.448788584744;5001.224810154432;5693.202951586698;5751.338596061507;5810.477057064884;5890.528757699288;9421.858672119786;9495.14543691071;9508.429494230368;9542.42745435276;9571.37786043905;7784.6886124554385;9428.151466367786;9515.524223788922;9736.513174341113;9781.266405019795;7092;7267.672954717156;7286.817829554304;7336;7343.0086938264785;7855.7250496232355;7881.763547093597;7937.2459616336355;7969.36245100379;7983.481073730189;6392.712327945161;7117.003619493172;7251.274872512707;7327.303906128909;7471.3649339806725;7024.683889224895;7130.465215108784;7140.071790667388;7149.034880291094;7177.102862142232;6687.832804179934;6798.966005169942;6811.761588344384;6841.110655614738;6853.280405557344;4853.320535125156;4862.805487780449;4887.926681099858;4932.63005274613;4952.059108769322;4916.926246106383;5004;5016.6237532184505;5042.042012017705;5090.4655011223285 07:52:21 INFO - PROCESS | 2005 | |4;prototype.html;295.2132566709719;301.1582626558768;303.931615386538;305.28258592308066;313.2903972502283;4387.9122417551625;4946.653734238605;5263.263123169355;5377.516023557884;5407.486288802567;5215.58275337973;5225.608079394042;5344.973275133619;5348.839534813962;5366.382865970415;3826.521684789401;3826.5611890207297;4171.687123465752;4175.3945677876845;4185.28850095483;3864.7487913285545;4013.9397909031386;4153.833846646131;4202.2856114460465;4206.305959516676;3323.667633236681;3929.9214015719667;3994.740341877783;4021.1100782632116;4028.738132021409;3925.8429662813596;4029.4157347184496;4040.575739547364;4048.582995951423;4056.1076563156057;3023.21396436928;3235.88674396395;3456.3778519866414;3482.3284823284966;3509.2455122148863;4470.016596348798;5109.463506331856;5208.739563021872;5301.098813201765;5330.493603107699;3441.0277149518956;4140.668746500272;4557.612602928722;4603.332516785081;4620.389479943821;4703.811847526094;5323.387810401815;5588.329400471969;5644.516412778365;5709.372828743788;3349.2129349602824;3447.379471695094;3618.6743193112748;3839.5392552893554;3839.9616003839883;5573.972130139324;5576.637518561281;5982.4316689914385;5983.341832398432;5984.461398474158;3433.1073920780777;3719.939569556915;3893.980530097331;3902.8829135125425;3911.6088391160656;3310.4206763816237;3460.2387474755515;3879.980600097038;3900.0054985978395;3976.880693579197;4133.8966525836495;4573.519780423074;4597.908041839144;4610.861674149781;4625.814967401334;4720.5515476030405;4798.832040878552;5727.167306461893;5732;5756.30924289088;1123.5337335006045;1157.6584907452323;1171.0748508678048;1286.5689993852163;1292.3344477594046;740.3632875726871;859.9183077607618;872.6683860133236;876.6230520876085;881.8412685716632;4200.7059505834295;4429.955700442954;4498.910021799611;4651.790534461064;5057.494250574913;4760.976195119071;5589.860253493695;5618.719064046782;5623.240862483594;5639.238702775155;4523.773811309421;4862.398616740027;5067.949320506821;5089.6691715038405;5094.821681241138;2405.675233843409;2646.9809123487594;2668.6130511075785;2950.8524573771224;2975.9137914661424;5003.921803729949;5275.630705850554;5706.8612263255045;5824.534037277008;5910.044977511245;5353.143497040455;5520.972395137998;5752.712364381764;5763.279590051244;5818.912716309259;5009.849704508871;5254.710990895461;5834.912476312858;5883.14694369314;5927.199828023334;4523.932141017953;4960;5401.783928642967;5482.971300618797;5494.642848214853;4451.955480445284;4795.568398844121;5130.51260130287;5468.070428027325;5525.005499010217;5740.942590574208;5742.310922689304;5777.94222057774;5799.492132045614;5800.477956983892;2768.12809455356;2866.9283267917635;3305.7933854142584;3666.2300916806703;3720.5535335759882;5115.3680886570955;5190.455002224712;5743.913841292468;5751.0317880662205;5778.56660750437;4867.70793752376;5603.775848966159;5605.943940560543;5670.829875103754;5672.347680016851;4514.90970180588;5106.310648062464;5254.5533629641905;5423.511883930465;5608.775648973995;5087.262346959744;5140.172904902363;5256.6320357574605;5525.530329922001;5540.085885828954;5626.212330273683;5635.098384258499;5641.492265696107;5645.798138725818;5709.54323654115;4847.418309802705;5136.743162841768;5171.767270472763;5554.583406244467;5595.944040559705 07:52:21 INFO - PROCESS | 2005 | |5;yui.html;652.4323838260713;671.9764808231713;743.561298833688;760.1717868526193;774.1561697749454;14151.504697335582;14776.926115369408;14782.852171478295;14789.852101478982;14821.925890370547;13161.34193290334;13164.210147391163;13217.405216765244;13225.404856781444;13316.400761965711;626.295417655138;650.7397041183517;786.3591173193857;807.3460496997421;824.4929368438427;690.9758158464455;800.2437696376926;800.9118996910336;802.5305196460077;806.3307454812492;856.443311847298;856.5973992223645;857.8927634045745;859.0593300336122;859.2395729779159;813.259933460551;842.4439869685978;851.9701810436636;853.564682012172;853.6158728572136;624.3257282135284;638.8818068657313;639.9296077431479;640.6540468147194;643.3662842100574;13255.005874559447;13565.050446468751;13565.25391103489;13578.117422367613;13985.650358741113;11229.66311010671;13432.059755817;13517.662058448519;13779.931100344535;13948.302584870717;10991.395473248967;11209.831852522218;11238.606648767336;11259.943700281447;11612.245204061708;3649.2711428400416;3669.743117981742;3679.188343916332;3709.6290370962956;3716.684081853046;92701.14597708009;93487;94949;94973;96357;9985.500724963722;10277.691669249785;10406.01142891424;10503.369797812156;10598.629047983284;16709.331626734795;20586.58826823455;20597.485062873548;20601.58796824055;20620.896895515725;7614.390848732088;7672.810714339286;7704.614769261627;7772.572508511973;7792.766217013499;3794.8994791510154;4146.709730318848;4191.664666826647;4205.696234167418;4283.914321713548;2476.578981573101;2802.03329851201;3135.9216019599694;3173.682631736854;3278.4426647469986;558.9552835773128;564.6329885574328;610.255488304268;631.5358211714387;647.090837373491;619.6870580356891;625.8091282158986;631.1794666932968;641.6118248459708;656.4584218020152;8111.026676798822;8290.29532489733;8446;8985.394235671713;9192.725382697077;557.7964043124231;657.7303305644663;658.3317932298721;667.2826711285387;676.5703778100843;4114.321137012419;4406.5593440655675;4439.866803995886;4480.315116486221;4507;74125;76430.61784691153;106327;107452;113138.43430782958;83786.48640540794;89798.10201898028;94648;95621;95643.56534651986;83156.58421707853;85924;86008.13991860127;89686;91771.54114229386;9134.163651266617;9623.896000793777;9674.109687492031;9718.598907788131;9783.461909594756;51086;53181.734091329294;55086.72456637691;55231.44768552263;56116;68265;72795.27204727885;77596.8360474582;78008;80379;12142.453589588313;12167.756644866877;12201.328926909106;12415.93792031034;12697.42861571213;11535.596254131066;11747.765044698886;12299.877001229874;13719.794203086762;14156.362963666867;12908;13314.33428328599;13363.331833408485;13397.196168229937;13432.597022089352;12932;13090.80363794563;13242.53651122206;13292.667683307607;13302.866971330162;12650.620481385573;12833.935830320788;12865.935670321964;13150.408231629408;13282.933585332012;10748.946255268673;10826.51280692355;11165.776684466427;11248.887511124783;11700.47347869331;10985.61550345734;11177.776444470903;11602.88397116018;11615.709607259549;11674.241174323643 07:52:21 INFO - PROCESS | 2005 | __end_tp_report 07:52:21 INFO - PROCESS | 2005 | __start_cc_report 07:52:21 INFO - PROCESS | 2005 | _x_x_mozilla_cycle_collect,364 07:52:21 INFO - PROCESS | 2005 | __end_cc_report 07:52:21 INFO - PROCESS | 2005 | __startTimestamp1481903541028__endTimestamp 07:52:21 INFO - PROCESS | 2005 | 07:52:21 INFO - PROCESS | 2005 | ------- Summary: start ------- 07:52:21 INFO - PROCESS | 2005 | Number of tests: 6 07:52:21 INFO - PROCESS | 2005 | 07:52:21 INFO - PROCESS | 2005 | [#0] dojo.html Cycles:165 Average:5836.19 Median:6078.09 stddev:658.37 (10.8%) stddev-sans-first:632.77 07:52:21 INFO - PROCESS | 2005 | Values: 3430.6 3434.2 3439.4 3443.2 3477.2 5906.7 5922.7 5927.2 5937.8 5963.5 5916.8 5957.2 5997.9 6009.4 6016.8 5024.8 5331.8 5421.2 5429.6 5457.5 5409.3 5421.8 5441.0 5443.2 5482.0 5338.7 5357.3 5439.0 5459.6 5508.8 4335.8 4526.3 5366.6 5430.6 5452.8 5284.4 5416.5 5434.1 5461.9 5482.2 5476.8 5912.3 6041.9 6065.6 6090.2 5209.5 6182.4 6227.2 6232.0 6257.4 6229.0 6268.8 6306.7 6346.9 6363.7 6066.2 6067.0 6070.8 6075.5 6078.1 6439.3 6441.9 6486.2 6524.9 6529.3 6145.0 6173.6 6176.1 6225.6 6239.3 6254.4 6285.2 6321.4 6332.8 6359.8 6243.7 6251.2 6270.4 6281.2 6286.3 6182.9 6300.5 6308.7 6316.7 6317.5 4986.9 4999.2 5023.1 5029.5 5035.9 4431.3 4435.7 4499.2 4499.3 4513.8 5320.5 5393.8 6052.6 6086.4 6136.5 6360.0 6370.4 6374.3 6379.0 6383.6 5953.1 6003.9 6004.4 6012.5 6038.7 5550.7 5559.8 5570.7 5586.3 5619.9 6494.4 6526.4 6531.8 6535.1 6538.7 6140.4 6205.6 6235.8 6306.1 6374.0 5332.8 5356.6 6522.4 6531.1 6549.1 6252.8 6256.8 6274.6 6276.3 6287.4 6128.7 6155.2 6220.3 6312.4 6314.1 6130.3 6165.5 6167.2 6219.8 6262.4 5161.6 5181.9 6227.7 6231.6 6249.2 5634.8 5991.7 6061.7 6190.9 6222.5 5666.1 6156.0 6158.4 6164.3 6181.2 6040.5 6054.8 6113.6 6120.3 6148.8 07:52:21 INFO - PROCESS | 2005 | 07:52:21 INFO - PROCESS | 2005 | [#1] ext.html Cycles:180 Average:67495.17 Median:40219.80 stddev:145111.37 (360.8%) stddev-sans-first:145431.15 07:52:21 INFO - PROCESS | 2005 | Values: 454.7 465.4 467.3 514.3 521.7 28579.0 39236.6 40198.8 40240.8 40317.6 41153.0 41566.8 41602.6 41676.8 41763.0 9364.3 9526.2 9547.7 9551.8 9574.8 9380.8 9457.6 9477.5 9487.9 9505.4 9484.1 9519.7 9522.8 9549.8 9573.7 9465.7 9488.7 9489.7 9491.7 9518.5 9322.3 9426.4 9435.3 9454.8 9467.9 33928.7 39075.6 39267.8 39406.8 39463.6 3341.9 3344.9 3453.2 3847.0 4000.3 29048.6 29577.4 29716.4 29805.9 29887.9 2986.9 3076.5 3104.3 3107.1 3108.0 417596.0 493628.0 499077.5 501850.0 504811.0 61818.0 61933.0 62194.4 62314.4 62394.1 65198.7 65655.7 65827.7 65855.7 65926.3 16090.0 16320.1 16322.4 16337.6 16365.1 12344.0 12407.2 12430.3 12491.3 12546.9 15082.5 16817.2 18992.5 19017.0 19074.7 5962.9 6806.4 6938.8 7234.7 7276.7 714.4 829.8 959.7 960.3 1015.9 24016.5 29699.0 29785.0 29948.3 30348.4 809.5 906.9 1054.8 1067.0 1075.4 12217.9 14218.3 15461.8 15486.2 15835.8 519136.0 638665.0 645756.0 652025.0 652728.0 55895.2 56499.7 56654.2 57093.1 57211.0 1336.4 1354.0 1382.5 1382.9 1384.8 28723.0 29305.0 29385.6 29426.4 29804.6 50027.5 50175.5 50321.5 50484.7 50616.2 504947.0 511556.0 513633.0 513750.0 517111.4 26047.5 26250.6 26579.1 26689.2 26789.9 45200.8 45279.5 45622.8 46060.3 46545.0 37274.0 38080.6 38653.6 39198.8 40806.6 32477.5 37690.8 37834.6 37974.8 39033.8 37751.8 38112.8 38413.0 38713.4 38824.6 32813.3 34513.3 34527.0 34666.0 34988.0 25877.9 25968.9 26010.6 26117.2 26230.6 07:52:21 INFO - PROCESS | 2005 | 07:52:21 INFO - PROCESS | 2005 | [#2] jquery.html Cycles:180 Average:24364.98 Median:246129.50 stddev:46817.96 (19.0%) stddev-sans-first:46914.63 07:52:21 INFO - PROCESS | 2005 | Values: 368.7 371.2 383.0 385.8 399.9 17707.6 19142.0 19776.5 19805.7 19998.5 16586.9 18777.2 18877.9 19210.3 19237.5 4293.5 5279.6 5458.9 5463.0 5497.2 4852.5 5273.8 5324.2 5387.3 5394.7 5382.2 5392.1 5393.5 5398.0 5592.8 5796.3 5800.8 5927.6 5937.1 5940.7 5317.7 5343.8 5396.5 5732.1 5736.6 12897.5 13073.0 13121.7 13130.8 17593.0 2050.6 2274.4 2307.0 2399.4 2666.5 9819.0 10224.4 10263.0 10323.8 14396.6 1516.5 1840.0 1860.9 1879.8 1889.3 111319.0 112749.9 123199.0 125569.0 128540.4 11242.8 11245.8 11466.1 11808.0 11938.3 14631.7 14688.6 14691.6 14727.8 14730.9 7279.1 8228.4 8389.0 8469.1 8559.7 7951.0 8052.2 8178.8 8389.0 8392.2 4139.4 4554.6 4598.3 4612.3 4615.3 1909.3 1943.5 1957.9 1990.5 1999.8 732.9 865.2 866.4 914.1 978.4 20338.8 20640.3 21134.3 21567.6 21640.9 893.8 915.1 917.9 958.4 963.0 10703.9 10825.5 10862.7 11063.7 11148.6 245560.0 246021.0 246238.0 247600.8 247842.0 72409.0 101117.0 101659.0 120295.4 125150.4 948.4 963.9 993.5 993.9 994.6 14840.3 18816.2 18891.4 19044.9 19093.3 55995.0 57374.7 58065.4 58082.4 58121.4 79605.0 79993.0 82200.6 82485.2 83840.6 7859.3 8045.5 8094.3 8111.4 8122.3 8766.1 11517.9 12523.7 12572.7 12717.0 8710.0 10137.4 10613.4 10980.4 11101.3 10458.6 10785.0 10801.7 10943.7 11052.3 10376.6 11150.7 11182.9 11318.4 11497.7 7796.2 7981.7 8090.8 8227.1 8434.2 8303.3 10438.8 11023.7 11079.6 11086.9 07:52:21 INFO - PROCESS | 2005 | 07:52:21 INFO - PROCESS | 2005 | [#3] mootools.html Cycles:180 Average:5458.59 Median:5251.04 stddev:2965.63 (56.5%) stddev-sans-first:2956.43 07:52:21 INFO - PROCESS | 2005 | Values: 1169.4 1305.6 1535.1 1764.1 1797.0 6780.9 7571.2 7856.0 8532.4 8556.0 8064.7 8358.9 8405.0 8450.6 8506.0 1914.9 2355.7 2359.1 2362.2 2371.5 2327.2 2363.2 2381.3 2381.6 2386.2 2161.6 2196.3 2325.8 2331.2 2350.0 2310.6 2314.5 2334.2 2338.7 2344.3 2337.7 2358.1 2358.8 2362.5 2366.7 8420.1 8445.7 8473.3 8489.3 8490.9 5091.0 5228.0 5259.1 5271.5 5280.3 3321.3 3456.5 3533.8 3621.0 3623.6 1035.2 1054.5 1071.8 1086.6 1086.7 10853.7 10892.1 10945.9 11002.5 11073.2 4535.7 4653.0 4717.3 4733.2 4801.7 8014.4 9529.3 9543.8 9559.7 9568.2 5243.1 5259.0 5261.8 5276.6 5279.3 4105.3 4740.3 4749.5 4777.5 4843.1 3828.4 3835.3 3907.5 3944.9 3946.8 1016.8 1162.7 1272.3 1278.7 1289.2 759.6 852.6 893.6 896.9 912.0 5585.3 5654.9 5688.9 5726.5 5873.2 895.4 906.3 936.3 951.4 952.9 3709.1 3805.0 3846.1 3856.4 3925.8 8490.0 9870.7 10126.5 10283.4 10287.6 7175.3 10064.0 10075.9 10212.5 10229.4 7643.0 7835.1 7850.1 7852.9 7874.4 5001.2 5693.2 5751.3 5810.5 5890.5 9421.9 9495.1 9508.4 9542.4 9571.4 7784.7 9428.2 9515.5 9736.5 9781.3 7092.0 7267.7 7286.8 7336.0 7343.0 7855.7 7881.8 7937.2 7969.4 7983.5 6392.7 7117.0 7251.3 7327.3 7471.4 7024.7 7130.5 7140.1 7149.0 7177.1 6687.8 6799.0 6811.8 6841.1 6853.3 4853.3 4862.8 4887.9 4932.6 4952.1 4916.9 5004.0 5016.6 5042.0 5090.5 07:52:21 INFO - PROCESS | 2005 | 07:52:21 INFO - PROCESS | 2005 | [#4] prototype.html Cycles:180 Average:4436.97 Median:5006.89 stddev:1398.54 (27.9%) stddev-sans-first:1367.48 07:52:21 INFO - PROCESS | 2005 | Values: 295.2 301.2 303.9 305.3 313.3 4387.9 4946.7 5263.3 5377.5 5407.5 5215.6 5225.6 5345.0 5348.8 5366.4 3826.5 3826.6 4171.7 4175.4 4185.3 3864.7 4013.9 4153.8 4202.3 4206.3 3323.7 3929.9 3994.7 4021.1 4028.7 3925.8 4029.4 4040.6 4048.6 4056.1 3023.2 3235.9 3456.4 3482.3 3509.2 4470.0 5109.5 5208.7 5301.1 5330.5 3441.0 4140.7 4557.6 4603.3 4620.4 4703.8 5323.4 5588.3 5644.5 5709.4 3349.2 3447.4 3618.7 3839.5 3840.0 5574.0 5576.6 5982.4 5983.3 5984.5 3433.1 3719.9 3894.0 3902.9 3911.6 3310.4 3460.2 3880.0 3900.0 3976.9 4133.9 4573.5 4597.9 4610.9 4625.8 4720.6 4798.8 5727.2 5732.0 5756.3 1123.5 1157.7 1171.1 1286.6 1292.3 740.4 859.9 872.7 876.6 881.8 4200.7 4430.0 4498.9 4651.8 5057.5 4761.0 5589.9 5618.7 5623.2 5639.2 4523.8 4862.4 5067.9 5089.7 5094.8 2405.7 2647.0 2668.6 2950.9 2975.9 5003.9 5275.6 5706.9 5824.5 5910.0 5353.1 5521.0 5752.7 5763.3 5818.9 5009.8 5254.7 5834.9 5883.1 5927.2 4523.9 4960.0 5401.8 5483.0 5494.6 4452.0 4795.6 5130.5 5468.1 5525.0 5740.9 5742.3 5777.9 5799.5 5800.5 2768.1 2866.9 3305.8 3666.2 3720.6 5115.4 5190.5 5743.9 5751.0 5778.6 4867.7 5603.8 5605.9 5670.8 5672.3 4514.9 5106.3 5254.6 5423.5 5608.8 5087.3 5140.2 5256.6 5525.5 5540.1 5626.2 5635.1 5641.5 5645.8 5709.5 4847.4 5136.7 5171.8 5554.6 5595.9 07:52:21 INFO - PROCESS | 2005 | 07:52:21 INFO - PROCESS | 2005 | [#5] yui.html Cycles:180 Average:20259.77 Median:4493.66 stddev:29447.82 (655.3%) stddev-sans-first:29493.63 07:52:21 INFO - PROCESS | 2005 | Values: 652.4 672.0 743.6 760.2 774.2 14151.5 14776.9 14782.9 14789.9 14821.9 13161.3 13164.2 13217.4 13225.4 13316.4 626.3 650.7 786.4 807.3 824.5 691.0 800.2 800.9 802.5 806.3 856.4 856.6 857.9 859.1 859.2 813.3 842.4 852.0 853.6 853.6 624.3 638.9 639.9 640.7 643.4 13255.0 13565.1 13565.3 13578.1 13985.7 11229.7 13432.1 13517.7 13779.9 13948.3 10991.4 11209.8 11238.6 11259.9 11612.2 3649.3 3669.7 3679.2 3709.6 3716.7 92701.1 93487.0 94949.0 94973.0 96357.0 9985.5 10277.7 10406.0 10503.4 10598.6 16709.3 20586.6 20597.5 20601.6 20620.9 7614.4 7672.8 7704.6 7772.6 7792.8 3794.9 4146.7 4191.7 4205.7 4283.9 2476.6 2802.0 3135.9 3173.7 3278.4 559.0 564.6 610.3 631.5 647.1 619.7 625.8 631.2 641.6 656.5 8111.0 8290.3 8446.0 8985.4 9192.7 557.8 657.7 658.3 667.3 676.6 4114.3 4406.6 4439.9 4480.3 4507.0 74125.0 76430.6 106327.0 107452.0 113138.4 83786.5 89798.1 94648.0 95621.0 95643.6 83156.6 85924.0 86008.1 89686.0 91771.5 9134.2 9623.9 9674.1 9718.6 9783.5 51086.0 53181.7 55086.7 55231.4 56116.0 68265.0 72795.3 77596.8 78008.0 80379.0 12142.5 12167.8 12201.3 12415.9 12697.4 11535.6 11747.8 12299.9 13719.8 14156.4 12908.0 13314.3 13363.3 13397.2 13432.6 12932.0 13090.8 13242.5 13292.7 13302.9 12650.6 12833.9 12865.9 13150.4 13282.9 10748.9 10826.5 11165.8 11248.9 11700.5 10985.6 11177.8 11602.9 11615.7 11674.2 07:52:21 INFO - PROCESS | 2005 | -------- Summary: end -------- 07:52:21 INFO - PROCESS | 2005 | 07:52:21 INFO - TEST-INFO | 2005: exit 0 07:52:21 INFO - TEST-OK | dromaeo_css | took 1117374ms 07:52:21 INFO - TEST-START | kraken 07:52:21 INFO - operating with platform_type : mac_ 07:52:21 INFO - Initialising browser for kraken test... 07:52:21 INFO - TEST-INFO | started process 2011 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmph0R7uX/profile http://localhost:51293/getInfo.html) 07:52:24 INFO - PROCESS | 2011 | 2016-12-16 07:52:24.682 plugin-container[2012:18200] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x853f, name = 'com.apple.tsm.portname' 07:52:24 INFO - PROCESS | 2011 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:52:24 INFO - PROCESS | 2011 | 2016-12-16 07:52:24.685 plugin-container[2012:18200] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x431f, name = 'com.apple.CFPasteboardClient' 07:52:24 INFO - PROCESS | 2011 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:52:24 INFO - PROCESS | 2011 | 2016-12-16 07:52:24.685 plugin-container[2012:18200] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:52:24 INFO - PROCESS | 2011 | __metrics Screen width/height:1600/1200 07:52:24 INFO - PROCESS | 2011 | colorDepth:24 07:52:24 INFO - PROCESS | 2011 | Browser inner width/height: 1024/689 07:52:24 INFO - PROCESS | 2011 | __metrics 07:52:24 ERROR - PROCESS | 2011 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 07:52:25 INFO - TEST-INFO | 2011: exit 0 07:52:25 INFO - Browser initialized. 07:52:25 INFO - Running cycle 1/1 for kraken test... 07:52:25 INFO - TEST-INFO | started process 2013 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmph0R7uX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:52:28 INFO - PROCESS | 2013 | 2016-12-16 07:52:28.271 plugin-container[2014:18325] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x874b, name = 'com.apple.tsm.portname' 07:52:28 INFO - PROCESS | 2013 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:52:28 INFO - PROCESS | 2013 | 2016-12-16 07:52:28.272 plugin-container[2014:18325] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8537, name = 'com.apple.CFPasteboardClient' 07:52:28 INFO - PROCESS | 2013 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:52:28 INFO - PROCESS | 2013 | 2016-12-16 07:52:28.272 plugin-container[2014:18325] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:52:37 INFO - PROCESS | 2013 | RSS: Main: 229609472 07:52:37 INFO - PROCESS | 2013 | 07:52:41 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:51293/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51293/tests/kraken/driver.html?testName=audio-beat-detection) 07:52:42 INFO - PROCESS | 2013 | RSS: Main: 241487872 07:52:42 INFO - PROCESS | 2013 | 07:52:44 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:51293/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51293/tests/kraken/driver.html?testName=audio-dft) 07:52:45 INFO - PROCESS | 2013 | RSS: Main: 248926208 07:52:45 INFO - PROCESS | 2013 | 07:52:48 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:51293/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51293/tests/kraken/driver.html?testName=audio-fft) 07:52:49 INFO - PROCESS | 2013 | RSS: Main: 250884096 07:52:49 INFO - PROCESS | 2013 | 07:52:51 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:51293/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51293/tests/kraken/driver.html?testName=audio-oscillator) 07:52:51 INFO - PROCESS | 2013 | RSS: Main: 253493248 07:52:51 INFO - PROCESS | 2013 | 07:52:53 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:51293/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51293/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:52:54 INFO - PROCESS | 2013 | RSS: Main: 254558208 07:52:54 INFO - PROCESS | 2013 | 07:52:57 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:51293/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51293/tests/kraken/driver.html?testName=imaging-darkroom) 07:52:58 INFO - PROCESS | 2013 | RSS: Main: 258453504 07:52:58 INFO - PROCESS | 2013 | 07:53:01 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:51293/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51293/tests/kraken/driver.html?testName=imaging-desaturate) 07:53:01 INFO - PROCESS | 2013 | RSS: Main: 257421312 07:53:01 INFO - PROCESS | 2013 | 07:53:04 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:51293/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51293/tests/kraken/driver.html?testName=json-parse-financial) 07:53:05 INFO - PROCESS | 2013 | RSS: Main: 257515520 07:53:05 INFO - PROCESS | 2013 | 07:53:07 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:51293/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51293/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:53:07 INFO - PROCESS | 2013 | RSS: Main: 256614400 07:53:07 INFO - PROCESS | 2013 | 07:53:09 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:51293/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51293/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:53:10 INFO - PROCESS | 2013 | RSS: Main: 256630784 07:53:10 INFO - PROCESS | 2013 | 07:53:12 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:51293/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51293/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:53:13 INFO - PROCESS | 2013 | RSS: Main: 256724992 07:53:13 INFO - PROCESS | 2013 | 07:53:16 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:51293/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51293/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:53:16 INFO - PROCESS | 2013 | RSS: Main: 256995328 07:53:16 INFO - PROCESS | 2013 | 07:53:19 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:51293/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51293/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:53:20 INFO - PROCESS | 2013 | RSS: Main: 256892928 07:53:20 INFO - PROCESS | 2013 | 07:53:22 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:51293/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51293/tests/kraken/driver.html?testName=ai-astar) 07:53:22 INFO - PROCESS | 2013 | RSS: Main: 258740224 07:53:22 INFO - PROCESS | 2013 | 07:53:22 INFO - PROCESS | 2013 | __start_tp_report 07:53:22 INFO - PROCESS | 2013 | _x_x_mozilla_page_load 07:53:22 INFO - PROCESS | 2013 | _x_x_mozilla_page_load_details 07:53:22 INFO - PROCESS | 2013 | |i|pagename|runs| 07:53:22 INFO - PROCESS | 2013 | |0;ai-astar;106;118;117;135;171;175;121;119;119;118 07:53:22 INFO - PROCESS | 2013 | |1;audio-beat-detection;145;114;132;177;115;117;104;109;142;128 07:53:22 INFO - PROCESS | 2013 | |2;audio-dft;272;252;196;214;211;279;227;196;194;189 07:53:22 INFO - PROCESS | 2013 | |3;audio-fft;81;83;66;81;60;58;67;51;69;50 07:53:22 INFO - PROCESS | 2013 | |4;audio-oscillator;86;70;87;71;68;74;83;69;73;88 07:53:22 INFO - PROCESS | 2013 | |5;imaging-gaussian-blur;93;88;77;133;131;87;94;116;90;85 07:53:22 INFO - PROCESS | 2013 | |6;imaging-darkroom;146;91;96;95;97;122;134;99;151;148 07:53:22 INFO - PROCESS | 2013 | |7;imaging-desaturate;89;94;87;86;112;71;145;144;117;90 07:53:22 INFO - PROCESS | 2013 | |8;json-parse-financial;57;58;56;60;61;62;59;61;60;59 07:53:22 INFO - PROCESS | 2013 | |9;json-stringify-tinderbox;68;69;76;84;79;75;70;70;74;73 07:53:22 INFO - PROCESS | 2013 | |10;stanford-crypto-aes;104;84;77;92;102;83;86;84;86;83 07:53:22 INFO - PROCESS | 2013 | |11;stanford-crypto-ccm;151;160;144;140;147;147;142;146;234;146 07:53:22 INFO - PROCESS | 2013 | |12;stanford-crypto-pbkdf2;168;172;169;165;172;203;235;181;164;191 07:53:22 INFO - PROCESS | 2013 | |13;stanford-crypto-sha256-iterative;69;67;70;77;93;89;91;79;68;69 07:53:22 INFO - PROCESS | 2013 | __end_tp_report 07:53:22 INFO - PROCESS | 2013 | __start_cc_report 07:53:22 INFO - PROCESS | 2013 | _x_x_mozilla_cycle_collect,986 07:53:22 INFO - PROCESS | 2013 | __end_cc_report 07:53:22 INFO - PROCESS | 2013 | __startTimestamp1481903602522__endTimestamp 07:53:22 INFO - PROCESS | 2013 | 07:53:22 INFO - PROCESS | 2013 | ------- Summary: start ------- 07:53:22 INFO - PROCESS | 2013 | Number of tests: 14 07:53:22 INFO - PROCESS | 2013 | 07:53:22 INFO - PROCESS | 2013 | [#0] ai-astar Cycles:10 Average:129.90 Median:120.00 stddev:23.77 (19.8%) stddev-sans-first:23.59 07:53:22 INFO - PROCESS | 2013 | Values: 106.0 118.0 117.0 135.0 171.0 175.0 121.0 119.0 119.0 118.0 07:53:22 INFO - PROCESS | 2013 | 07:53:22 INFO - PROCESS | 2013 | [#1] audio-beat-detection Cycles:10 Average:128.30 Median:130.00 stddev:21.92 (16.9%) stddev-sans-first:22.40 07:53:22 INFO - PROCESS | 2013 | Values: 145.0 114.0 132.0 177.0 115.0 117.0 104.0 109.0 142.0 128.0 07:53:22 INFO - PROCESS | 2013 | 07:53:22 INFO - PROCESS | 2013 | [#2] audio-dft Cycles:10 Average:223.00 Median:220.50 stddev:33.46 (15.2%) stddev-sans-first:30.43 07:53:22 INFO - PROCESS | 2013 | Values: 272.0 252.0 196.0 214.0 211.0 279.0 227.0 196.0 194.0 189.0 07:53:22 INFO - PROCESS | 2013 | 07:53:22 INFO - PROCESS | 2013 | [#3] audio-fft Cycles:10 Average:66.60 Median:68.00 stddev:12.14 (17.9%) stddev-sans-first:11.70 07:53:22 INFO - PROCESS | 2013 | Values: 81.0 83.0 66.0 81.0 60.0 58.0 67.0 51.0 69.0 50.0 07:53:22 INFO - PROCESS | 2013 | 07:53:22 INFO - PROCESS | 2013 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:78.50 stddev:8.12 (10.3%) stddev-sans-first:7.91 07:53:22 INFO - PROCESS | 2013 | Values: 86.0 70.0 87.0 71.0 68.0 74.0 83.0 69.0 73.0 88.0 07:53:22 INFO - PROCESS | 2013 | 07:53:22 INFO - PROCESS | 2013 | [#5] imaging-gaussian-blur Cycles:10 Average:99.40 Median:87.50 stddev:19.87 (22.7%) stddev-sans-first:20.94 07:53:22 INFO - PROCESS | 2013 | Values: 93.0 88.0 77.0 133.0 131.0 87.0 94.0 116.0 90.0 85.0 07:53:22 INFO - PROCESS | 2013 | 07:53:22 INFO - PROCESS | 2013 | [#6] imaging-darkroom Cycles:10 Average:117.90 Median:93.00 stddev:24.92 (26.8%) stddev-sans-first:24.27 07:53:22 INFO - PROCESS | 2013 | Values: 146.0 91.0 96.0 95.0 97.0 122.0 134.0 99.0 151.0 148.0 07:53:22 INFO - PROCESS | 2013 | 07:53:22 INFO - PROCESS | 2013 | [#7] imaging-desaturate Cycles:10 Average:103.50 Median:86.50 stddev:25.24 (29.2%) stddev-sans-first:26.22 07:53:22 INFO - PROCESS | 2013 | Values: 89.0 94.0 87.0 86.0 112.0 71.0 145.0 144.0 117.0 90.0 07:53:22 INFO - PROCESS | 2013 | 07:53:22 INFO - PROCESS | 2013 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:60.00 stddev:1.89 (3.1%) stddev-sans-first:1.81 07:53:22 INFO - PROCESS | 2013 | Values: 57.0 58.0 56.0 60.0 61.0 62.0 59.0 61.0 60.0 59.0 07:53:22 INFO - PROCESS | 2013 | 07:53:22 INFO - PROCESS | 2013 | [#9] json-stringify-tinderbox Cycles:10 Average:73.80 Median:74.50 stddev:4.98 (6.7%) stddev-sans-first:4.82 07:53:22 INFO - PROCESS | 2013 | Values: 68.0 69.0 76.0 84.0 79.0 75.0 70.0 70.0 74.0 73.0 07:53:22 INFO - PROCESS | 2013 | 07:53:22 INFO - PROCESS | 2013 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:84.00 stddev:8.69 (10.3%) stddev-sans-first:7.05 07:53:22 INFO - PROCESS | 2013 | Values: 104.0 84.0 77.0 92.0 102.0 83.0 86.0 84.0 86.0 83.0 07:53:22 INFO - PROCESS | 2013 | 07:53:22 INFO - PROCESS | 2013 | [#11] stanford-crypto-ccm Cycles:10 Average:155.70 Median:147.00 stddev:28.05 (19.1%) stddev-sans-first:29.70 07:53:22 INFO - PROCESS | 2013 | Values: 151.0 160.0 144.0 140.0 147.0 147.0 142.0 146.0 234.0 146.0 07:53:22 INFO - PROCESS | 2013 | 07:53:22 INFO - PROCESS | 2013 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.00 Median:176.50 stddev:22.39 (12.7%) stddev-sans-first:23.16 07:53:22 INFO - PROCESS | 2013 | Values: 168.0 172.0 169.0 165.0 172.0 203.0 235.0 181.0 164.0 191.0 07:53:22 INFO - PROCESS | 2013 | 07:53:22 INFO - PROCESS | 2013 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.20 Median:78.00 stddev:10.32 (13.2%) stddev-sans-first:10.51 07:53:22 INFO - PROCESS | 2013 | Values: 69.0 67.0 70.0 77.0 93.0 89.0 91.0 79.0 68.0 69.0 07:53:22 INFO - PROCESS | 2013 | -------- Summary: end -------- 07:53:22 INFO - PROCESS | 2013 | 07:53:23 INFO - TEST-INFO | 2013: exit 0 07:53:23 INFO - TEST-OK | kraken | took 61855ms 07:53:23 INFO - SUITE-END | took 1179s 07:53:23 INFO - Completed test suite (00:19:39) 07:53:23 INFO - javascript benchmark 07:53:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7105.274682051752, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3430.554027976363, 3434.2272988577574, 3439.4496880499123, 3443.208062145708, 3477.1654802847324, 5906.70466476676, 5922.733476993535, 5927.170196172534, 5937.792177273796, 5963.463288304052, 5916.8224953251365, 5957.225560677106, 5997.910031349522, 6009.4291042351015, 6016.849578760533, 5024.84925452237, 5331.840044798662, 5421.241026256327, 5429.647072940266, 5457.454254574551, 5409.29679141711, 5421.810236641718, 5440.972795136019, 5443.156310771837, 5481.972590137044, 5338.706371149585, 5357.330333708286, 5438.972805135969, 5459.563234941215, 5508.779648814043, 4335.84824531143, 4526.275795872661, 5366.570674346043, 5430.56555475563, 5452.836414907559, 5284.392294886099, 5416.458354164552, 5434.103372943459, 5461.9453805461835, 5482.17767334899, 5476.808311709111, 5912.320083190445, 6041.939580604182, 6065.636061836304, 6090.177825993478, 5209.453007434203, 6182.412670796267, 6227.221597300338, 6231.968840155816, 6257.405546473078, 6229.034499652561, 6268.78059267928, 6306.653134077624, 6346.87306253877, 6363.713632886485, 6066.181065556138, 6066.969665151734, 6070.7875224366935, 6075.48358389533, 6078.088286757022, 6439.291677915426, 6441.871162576722, 6486.221653401528, 6524.869502610016, 6529.2817790043055, 6144.969275153596, 6173.567850250529, 6176.104464852661, 6225.595336303126, 6239.344868788712, 6254.405831446005, 6285.151504546919, 6321.399467050623, 6332.8416789579705, 6359.777407790798, 6243.719032643542, 6251.187345645037, 6270.372962703785, 6281.214848143982, 6286.339934306923, 6182.907256391158, 6300.527460440485, 6308.684565771785, 6316.747330106836, 6317.46301564363, 4986.850394488171, 4999.200127979506, 5023.095842748267, 5029.497050294941, 5035.899282014412, 4431.290993441034, 4435.689501734848, 4499.235130027903, 4499.280115181556, 4513.774311284423, 5320.494553017457, 5393.7572809223675, 6052.606580572248, 6086.360932102154, 6136.539759518054, 6359.96820015897, 6370.394812492806, 6374.298827129012, 6379.011253255753, 6383.6488993104895, 5953.077273022688, 6003.939960600425, 6004.42957918997, 6012.518998480111, 6038.698065096728, 5550.72246387679, 5559.833205003856, 5570.749316280777, 5586.273784408001, 5619.887602247933, 6494.383033611799, 6526.4452521536205, 6531.771388001397, 6535.0850880876715, 6538.673066346663, 6140.412224875342, 6205.596636218631, 6235.844103897258, 6306.148669929685, 6374.0, 5332.840014799563, 5356.625036247426, 6522.445592124533, 6531.085648009187, 6549.148610680581, 6252.781152659635, 6256.812295631138, 6274.623522588659, 6276.278228003838, 6287.434130928238, 6128.717018009172, 6155.230596175478, 6220.284667263322, 6312.43188113072, 6314.052892066226, 6130.336988992987, 6165.475934545434, 6167.229096362955, 6219.844503887439, 6262.373762623702, 5161.587073034073, 5181.870453238699, 6227.688615569113, 6231.626102433868, 6249.218847644044, 5634.802781902614, 5991.730372133177, 6061.666608336407, 6190.938090619036, 6222.471089957405, 5666.065099258741, 6155.96922015405, 6158.414950579688, 6164.321924588381, 6181.196444462191, 6040.516758659384, 6054.788082417094, 6113.57204995646, 6120.296165940974, 6148.754049838135], "value": 5796.046115006938, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [454.6908102490305, 465.4228756342136, 467.3480494709882, 514.2851436503261, 521.6504941689068, 28579.0, 39236.60763392365, 40198.79900600496, 40240.79879600605, 40317.596824031825, 41152.971175720544, 41566.79216603913, 41602.58397416025, 41676.791616041955, 41763.0, 9364.250859931206, 9526.190273826733, 9547.713568592953, 9551.761205969837, 9574.760630984212, 9380.765480862965, 9457.62169513222, 9477.47873866937, 9487.857682134774, 9505.429674219535, 9484.051594840495, 9519.714408567754, 9522.80954380912, 9549.809003819919, 9573.712788616353, 9465.716028519155, 9488.715338539854, 9489.715308540686, 9491.715248542485, 9518.476483793389, 9322.25421966241, 9426.434413935185, 9435.339526233167, 9454.810903781954, 9467.857982130274, 33928.660713393045, 39075.60924390748, 39267.8036609818, 39406.80296598528, 39463.60536394628, 3341.899743007714, 3344.916377090592, 3453.2230248194205, 3847.03824043989, 4000.3399439092514, 29048.56427153573, 29577.408451830845, 29716.405671886656, 29805.850970745225, 29887.850560747058, 2986.8655910483862, 3076.492378757502, 3104.3170502489415, 3107.052349033544, 3107.984460077685, 417596.0, 493628.0, 499077.50461247825, 501850.0, 504811.0, 61818.0, 61933.0, 62194.37805621886, 62314.376856231764, 62394.0640890387, 65198.674006630616, 65655.70205042801, 65827.67086164538, 65855.67072164704, 65926.34073659297, 16090.034597924163, 16320.102394368187, 16322.428714994918, 16337.591560210853, 16365.099919504542, 12344.012479001658, 12407.193532420364, 12430.316332601613, 12491.312977786127, 12546.87453125457, 15082.54752357431, 16817.243224054702, 18992.525186870163, 19017.0, 19074.713879291823, 5962.940370596325, 6806.353396427331, 6938.757143499954, 7234.674439650228, 7276.745313913988, 714.4391652552721, 829.8298848735994, 959.7024922274118, 960.3373672166183, 1015.9441230732381, 24016.51966960651, 29699.0, 29785.0, 29948.251293717833, 30348.393032139233, 809.4738420026912, 906.918377346042, 1054.8048611006989, 1067.0, 1075.3762817565794, 12217.877821221675, 14218.28908554568, 15461.84538154604, 15486.225688715744, 15835.762463563056, 519136.0, 638665.0, 645756.0, 652025.0, 652728.0, 55895.16157257644, 56499.71750141223, 56654.15018774722, 57093.143602845994, 57211.0, 1336.4253371050543, 1353.9661508462368, 1382.5092092307286, 1382.9446822127002, 1384.847666756656, 28723.0, 29305.0, 29385.559216612197, 29426.411471770873, 29804.552931706476, 50027.499725002286, 50175.494735158005, 50321.49678503168, 50484.747576261885, 50616.24075638942, 504947.0, 511556.0, 513633.0, 513750.0, 517111.41444292536, 26047.479050419264, 26250.60624090602, 26579.069732559266, 26689.199324020312, 26789.86605066962, 45200.77399612981, 45279.54720452885, 45622.771886140355, 46060.30909536293, 46545.0, 37274.0, 38080.61919380771, 38653.613463865004, 39198.82403527899, 40806.57176998791, 32477.51283730793, 37690.811545942095, 37834.62165378311, 37974.810125949196, 39033.80483097566, 37751.81124094362, 38112.809435952644, 38413.0, 38713.4192987111, 38824.6117538821, 32813.343733124726, 34513.30973380468, 34527.0, 34665.960021199404, 34988.0, 25877.870610646827, 25968.8701556491, 26010.60984085278, 26117.216483505526, 26230.58477030131], "value": 19521.920559899187, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.6995098994318, 371.15006634806286, 383.04812540836025, 385.753118004477, 399.85405327055616, 17707.55731106723, 19142.0, 19776.505587360323, 19805.702914456277, 19998.500037499034, 16586.917065414655, 18777.15502802374, 18877.905610471964, 19210.327638532654, 19237.519062023457, 4293.506246781629, 5279.5512381447625, 5458.918116228259, 5462.962037212937, 5497.202905578689, 4852.49048849871, 5273.841784746463, 5324.174752913285, 5387.299651045379, 5394.676319420828, 5382.2195781611645, 5392.083345831218, 5393.514583687467, 5397.973010134944, 5592.7762889484375, 5796.30444346679, 5800.796972105956, 5927.585069045147, 5937.109433584954, 5940.70296485174, 5317.707526086064, 5343.759530821122, 5396.541293990015, 5732.0542110551705, 5736.627119237278, 12897.484100635964, 13073.0, 13121.737565248737, 13130.803037954438, 17593.0, 2050.6103840270302, 2274.363178310059, 2306.953860922772, 2399.4121440247077, 2666.520026395248, 9818.950905245429, 10224.386536807815, 10262.973702629752, 10323.79352412955, 14396.64008399788, 1516.5222954769213, 1840.0, 1860.9348672796386, 1879.755631767875, 1889.2726300374318, 111319.0, 112749.87250127476, 123199.0, 125569.0, 128540.35729821384, 11242.831357529643, 11245.775084498264, 11466.08271338291, 11807.992641251009, 11938.28370297785, 14631.707365852624, 14688.55934321972, 14691.55925322242, 14727.779083313759, 14730.852691472948, 7279.053723015974, 8228.42401031922, 8389.0, 8469.068402475723, 8559.657613695506, 7950.960245198737, 8052.194780521901, 8178.836423271501, 8389.0, 8392.244697977212, 4139.3583994480905, 4554.63562914966, 4598.333241680005, 4612.262038073892, 4615.263137115543, 1909.303104366924, 1943.4655469745933, 1957.8629495935434, 1990.5421752996601, 1999.8200161985492, 732.9303716146958, 865.1910463716446, 866.4368160695473, 914.0767824497173, 978.3933960944261, 20338.79661203369, 20640.27759028427, 21134.260300889397, 21567.56864862694, 21640.891795541236, 893.7586851550045, 915.1443400420628, 917.8898532176048, 958.3674774648698, 962.9759256018516, 10703.876093010278, 10825.512851921683, 10862.721976275914, 11063.668089957315, 11148.554057837595, 245560.0, 246021.0, 246238.0, 247600.76199618887, 247842.0, 72409.0, 101117.0, 101659.0, 120295.39852300682, 125150.37424812818, 948.4072454715803, 963.9036096390305, 993.4536005197112, 993.9155171810477, 994.6476582881434, 14840.332185051482, 18816.24735010584, 18891.43325700231, 19044.904775476032, 19093.331733389266, 55995.0, 57374.7131264341, 58065.419345806, 58082.4191758077, 58121.418785813294, 79605.0, 79993.0, 82200.58899705463, 82485.17514824776, 83840.58079709562, 7859.331956783737, 8045.477043992122, 8094.271515563628, 8111.4321997461975, 8122.309603683753, 8766.123387661182, 11517.884821151682, 12523.686907827378, 12572.748545028866, 12717.0, 8710.041895391629, 10137.391756494633, 10613.363198208132, 10980.396078215776, 11101.333919964827, 10458.58165673395, 10785.029347358775, 10801.729956751144, 10943.726406839893, 11052.336859788438, 10376.584936602754, 11150.721231969266, 11182.888171118184, 11318.377489238172, 11497.655070347902, 7796.181400952818, 7981.680732770624, 8090.838183236185, 8227.053888802864, 8434.198751118634, 8303.294219991369, 10438.843417348899, 11023.724406889893, 11079.612213572485, 11086.946740059682], "value": 8969.870071580433, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1169.4445138559183, 1305.627896049626, 1535.0942943663244, 1764.082677007955, 1797.0206237600498, 6780.9321906780915, 7571.205023472525, 7855.978722766033, 8532.402731808776, 8556.016058153315, 8064.71773487928, 8358.874616880752, 8405.033421156553, 8450.57747112645, 8506.0, 1914.904254787262, 2355.693759811222, 2359.091749676378, 2362.2086600988605, 2371.537550177716, 2327.173853282086, 2363.231949616373, 2381.2856143156982, 2381.630847218675, 2386.164842305188, 2161.6273666221905, 2196.253273886878, 2325.7557956414585, 2331.172433786007, 2350.048230466664, 2310.572544079351, 2314.5370925814905, 2334.159702507096, 2338.684277622516, 2344.2615576093476, 2337.7077865266842, 2358.13927916311, 2358.8348815582917, 2362.503874186406, 2366.7041619797524, 8420.073791882887, 8445.746627601182, 8473.322134229247, 8489.320854331638, 8490.915090849074, 5091.0, 5228.0, 5259.053370393328, 5271.525562699337, 5280.260763493114, 3321.3191295784304, 3456.4988076728987, 3533.7703049301713, 3621.022323972513, 3623.601403845575, 1035.2339268941005, 1054.510936124378, 1071.7695695425443, 1086.625114335561, 1086.7174534620976, 10853.728656783565, 10892.128629709605, 10945.90540945907, 11002.50488728009, 11073.224874258805, 4535.682502224812, 4652.95347046532, 4717.292406139038, 4733.171694953369, 4801.735904525284, 8014.398920081017, 9529.332946693665, 9543.761405964768, 9559.665411710557, 9568.186704130088, 5243.10867152585, 5258.973705131526, 5261.76322065508, 5276.577873770089, 5279.313689220454, 4105.281575724236, 4740.312654665055, 4749.4775574686755, 4777.474477807438, 4843.055604157226, 3828.406596977473, 3835.290471262825, 3907.4529565860803, 3944.9013774655864, 3946.8026598669953, 1016.8373060310315, 1162.7093226693328, 1272.2748033620746, 1278.7314663920681, 1289.2006955687534, 759.6429678051308, 852.6333676519032, 893.5755516129916, 896.9282457403392, 911.9635214591475, 5585.273914391103, 5654.9151762723595, 5688.886222275614, 5726.4559866813415, 5873.177755114288, 895.3598177303129, 906.2749800159977, 936.2509992006504, 951.410125722043, 952.8999455057258, 3709.146896213886, 3805.0487378155462, 3846.076941534012, 3856.36369998947, 3925.784081875467, 8489.95755021221, 9870.654527091518, 10126.481027845883, 10283.43441110746, 10287.639932602324, 7175.282471752783, 10064.043915827984, 10075.899241007643, 10212.489375531193, 10229.386236825814, 7643.044619422572, 7835.0597928247835, 7850.097238817495, 7852.921470785333, 7874.448788584744, 5001.224810154432, 5693.202951586698, 5751.338596061507, 5810.477057064884, 5890.528757699288, 9421.858672119786, 9495.14543691071, 9508.429494230368, 9542.42745435276, 9571.37786043905, 7784.6886124554385, 9428.151466367786, 9515.524223788922, 9736.513174341113, 9781.266405019795, 7092.0, 7267.672954717156, 7286.817829554304, 7336.0, 7343.0086938264785, 7855.7250496232355, 7881.763547093597, 7937.2459616336355, 7969.36245100379, 7983.481073730189, 6392.712327945161, 7117.003619493172, 7251.274872512707, 7327.303906128909, 7471.3649339806725, 7024.683889224895, 7130.465215108784, 7140.071790667388, 7149.034880291094, 7177.102862142232, 6687.832804179934, 6798.966005169942, 6811.761588344384, 6841.110655614738, 6853.280405557344, 4853.320535125156, 4862.805487780449, 4887.926681099858, 4932.63005274613, 4952.059108769322, 4916.926246106383, 5004.0, 5016.6237532184505, 5042.042012017705, 5090.4655011223285], "value": 4429.931672117945, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.2132566709719, 301.1582626558768, 303.931615386538, 305.28258592308066, 313.2903972502283, 4387.9122417551625, 4946.653734238605, 5263.263123169355, 5377.516023557884, 5407.486288802567, 5215.58275337973, 5225.608079394042, 5344.973275133619, 5348.839534813962, 5366.382865970415, 3826.521684789401, 3826.5611890207297, 4171.687123465752, 4175.3945677876845, 4185.28850095483, 3864.7487913285545, 4013.9397909031386, 4153.833846646131, 4202.2856114460465, 4206.305959516676, 3323.667633236681, 3929.9214015719667, 3994.740341877783, 4021.1100782632116, 4028.738132021409, 3925.8429662813596, 4029.4157347184496, 4040.575739547364, 4048.582995951423, 4056.1076563156057, 3023.21396436928, 3235.88674396395, 3456.3778519866414, 3482.3284823284966, 3509.2455122148863, 4470.016596348798, 5109.463506331856, 5208.739563021872, 5301.098813201765, 5330.493603107699, 3441.0277149518956, 4140.668746500272, 4557.612602928722, 4603.332516785081, 4620.389479943821, 4703.811847526094, 5323.387810401815, 5588.329400471969, 5644.516412778365, 5709.372828743788, 3349.2129349602824, 3447.379471695094, 3618.6743193112748, 3839.5392552893554, 3839.9616003839883, 5573.972130139324, 5576.637518561281, 5982.4316689914385, 5983.341832398432, 5984.461398474158, 3433.1073920780777, 3719.939569556915, 3893.980530097331, 3902.8829135125425, 3911.6088391160656, 3310.4206763816237, 3460.2387474755515, 3879.980600097038, 3900.0054985978395, 3976.880693579197, 4133.8966525836495, 4573.519780423074, 4597.908041839144, 4610.861674149781, 4625.814967401334, 4720.5515476030405, 4798.832040878552, 5727.167306461893, 5732.0, 5756.30924289088, 1123.5337335006045, 1157.6584907452323, 1171.0748508678048, 1286.5689993852163, 1292.3344477594046, 740.3632875726871, 859.9183077607618, 872.6683860133236, 876.6230520876085, 881.8412685716632, 4200.7059505834295, 4429.955700442954, 4498.910021799611, 4651.790534461064, 5057.494250574913, 4760.976195119071, 5589.860253493695, 5618.719064046782, 5623.240862483594, 5639.238702775155, 4523.773811309421, 4862.398616740027, 5067.949320506821, 5089.6691715038405, 5094.821681241138, 2405.675233843409, 2646.9809123487594, 2668.6130511075785, 2950.8524573771224, 2975.9137914661424, 5003.921803729949, 5275.630705850554, 5706.8612263255045, 5824.534037277008, 5910.044977511245, 5353.143497040455, 5520.972395137998, 5752.712364381764, 5763.279590051244, 5818.912716309259, 5009.849704508871, 5254.710990895461, 5834.912476312858, 5883.14694369314, 5927.199828023334, 4523.932141017953, 4960.0, 5401.783928642967, 5482.971300618797, 5494.642848214853, 4451.955480445284, 4795.568398844121, 5130.51260130287, 5468.070428027325, 5525.005499010217, 5740.942590574208, 5742.310922689304, 5777.94222057774, 5799.492132045614, 5800.477956983892, 2768.12809455356, 2866.9283267917635, 3305.7933854142584, 3666.2300916806703, 3720.5535335759882, 5115.3680886570955, 5190.455002224712, 5743.913841292468, 5751.0317880662205, 5778.56660750437, 4867.70793752376, 5603.775848966159, 5605.943940560543, 5670.829875103754, 5672.347680016851, 4514.90970180588, 5106.310648062464, 5254.5533629641905, 5423.511883930465, 5608.775648973995, 5087.262346959744, 5140.172904902363, 5256.6320357574605, 5525.530329922001, 5540.085885828954, 5626.212330273683, 5635.098384258499, 5641.492265696107, 5645.798138725818, 5709.54323654115, 4847.418309802705, 5136.743162841768, 5171.767270472763, 5554.583406244467, 5595.944040559705], "value": 3988.6188907629603, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [652.4323838260713, 671.9764808231713, 743.561298833688, 760.1717868526193, 774.1561697749454, 14151.504697335582, 14776.926115369408, 14782.852171478295, 14789.852101478982, 14821.925890370547, 13161.34193290334, 13164.210147391163, 13217.405216765244, 13225.404856781444, 13316.400761965711, 626.295417655138, 650.7397041183517, 786.3591173193857, 807.3460496997421, 824.4929368438427, 690.9758158464455, 800.2437696376926, 800.9118996910336, 802.5305196460077, 806.3307454812492, 856.443311847298, 856.5973992223645, 857.8927634045745, 859.0593300336122, 859.2395729779159, 813.259933460551, 842.4439869685978, 851.9701810436636, 853.564682012172, 853.6158728572136, 624.3257282135284, 638.8818068657313, 639.9296077431479, 640.6540468147194, 643.3662842100574, 13255.005874559447, 13565.050446468751, 13565.25391103489, 13578.117422367613, 13985.650358741113, 11229.66311010671, 13432.059755817, 13517.662058448519, 13779.931100344535, 13948.302584870717, 10991.395473248967, 11209.831852522218, 11238.606648767336, 11259.943700281447, 11612.245204061708, 3649.2711428400416, 3669.743117981742, 3679.188343916332, 3709.6290370962956, 3716.684081853046, 92701.14597708009, 93487.0, 94949.0, 94973.0, 96357.0, 9985.500724963722, 10277.691669249785, 10406.01142891424, 10503.369797812156, 10598.629047983284, 16709.331626734795, 20586.58826823455, 20597.485062873548, 20601.58796824055, 20620.896895515725, 7614.390848732088, 7672.810714339286, 7704.614769261627, 7772.572508511973, 7792.766217013499, 3794.8994791510154, 4146.709730318848, 4191.664666826647, 4205.696234167418, 4283.914321713548, 2476.578981573101, 2802.03329851201, 3135.9216019599694, 3173.682631736854, 3278.4426647469986, 558.9552835773128, 564.6329885574328, 610.255488304268, 631.5358211714387, 647.090837373491, 619.6870580356891, 625.8091282158986, 631.1794666932968, 641.6118248459708, 656.4584218020152, 8111.026676798822, 8290.29532489733, 8446.0, 8985.394235671713, 9192.725382697077, 557.7964043124231, 657.7303305644663, 658.3317932298721, 667.2826711285387, 676.5703778100843, 4114.321137012419, 4406.5593440655675, 4439.866803995886, 4480.315116486221, 4507.0, 74125.0, 76430.61784691153, 106327.0, 107452.0, 113138.43430782958, 83786.48640540794, 89798.10201898028, 94648.0, 95621.0, 95643.56534651986, 83156.58421707853, 85924.0, 86008.13991860127, 89686.0, 91771.54114229386, 9134.163651266617, 9623.896000793777, 9674.109687492031, 9718.598907788131, 9783.461909594756, 51086.0, 53181.734091329294, 55086.72456637691, 55231.44768552263, 56116.0, 68265.0, 72795.27204727885, 77596.8360474582, 78008.0, 80379.0, 12142.453589588313, 12167.756644866877, 12201.328926909106, 12415.93792031034, 12697.42861571213, 11535.596254131066, 11747.765044698886, 12299.877001229874, 13719.794203086762, 14156.362963666867, 12908.0, 13314.33428328599, 13363.331833408485, 13397.196168229937, 13432.597022089352, 12932.0, 13090.80363794563, 13242.53651122206, 13292.667683307607, 13302.866971330162, 12650.620481385573, 12833.935830320788, 12865.935670321964, 13150.408231629408, 13282.933585332012, 10748.946255268673, 10826.51280692355, 11165.776684466427, 11248.887511124783, 11700.47347869331, 10985.61550345734, 11177.776444470903, 11602.88397116018, 11615.709607259549, 11674.241174323643], "value": 7174.2885266812145, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1581.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 118.0, 117.0, 135.0, 171.0, 175.0, 121.0, 119.0, 119.0, 118.0], "value": 129.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 114.0, 132.0, 177.0, 115.0, 117.0, 104.0, 109.0, 142.0, 128.0], "value": 128.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [272.0, 252.0, 196.0, 214.0, 211.0, 279.0, 227.0, 196.0, 194.0, 189.0], "value": 223.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 66.0, 81.0, 60.0, 58.0, 67.0, 51.0, 69.0, 50.0], "value": 66.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 87.0, 71.0, 68.0, 74.0, 83.0, 69.0, 73.0, 88.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 88.0, 77.0, 133.0, 131.0, 87.0, 94.0, 116.0, 90.0, 85.0], "value": 99.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 91.0, 96.0, 95.0, 97.0, 122.0, 134.0, 99.0, 151.0, 148.0], "value": 117.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 94.0, 87.0, 86.0, 112.0, 71.0, 145.0, 144.0, 117.0, 90.0], "value": 103.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 56.0, 60.0, 61.0, 62.0, 59.0, 61.0, 60.0, 59.0], "value": 59.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 76.0, 84.0, 79.0, 75.0, 70.0, 70.0, 74.0, 73.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 84.0, 77.0, 92.0, 102.0, 83.0, 86.0, 84.0, 86.0, 83.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 160.0, 144.0, 140.0, 147.0, 147.0, 142.0, 146.0, 234.0, 146.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 172.0, 169.0, 165.0, 172.0, 203.0, 235.0, 181.0, 164.0, 191.0], "value": 182.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 70.0, 77.0, 93.0, 89.0, 91.0, 79.0, 68.0, 69.0], "value": 77.2, "unit": "score"}]}]} 07:53:23 INFO - Return code: 0 07:53:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:53:23 ERROR - # TBPL SUCCESS # 07:53:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:53:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:53:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:53:23 INFO - 2016-12-16 07:53:23.827 screenresolution[2018:18720] starting screenresolution argv=screenresolution get 07:53:23 INFO - 2016-12-16 07:53:23.831 screenresolution[2018:18720] Display 0: 1600x1200x32@60 07:53:23 INFO - 2016-12-16 07:53:23.837 screenresolution[2019:18723] starting screenresolution argv=screenresolution list 07:53:23 INFO - Available Modes on Display 0 07:53:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:53:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:53:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:53:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:53:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:53:24 INFO - Intel Iris: 07:53:24 INFO - Chipset Model: Intel Iris 07:53:24 INFO - Type: GPU 07:53:24 INFO - Bus: Built-In 07:53:24 INFO - VRAM (Dynamic, Max): 1536 MB 07:53:24 INFO - Vendor: Intel (0x8086) 07:53:24 INFO - Device ID: 0x0a2e 07:53:24 INFO - Revision ID: 0x0009 07:53:24 INFO - Displays: 07:53:24 INFO - Display: 07:53:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:53:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:53:24 INFO - Display Serial Number: 1600x1200 60 07:53:24 INFO - Main Display: Yes 07:53:24 INFO - Mirror: Off 07:53:24 INFO - Online: Yes 07:53:24 INFO - Rotation: Supported 07:53:24 INFO - Return code: 0 07:53:24 INFO - Running post-action listener: _resource_record_post_action 07:53:24 INFO - [mozharness: 2016-12-16 15:53:24.081581Z] Finished run-tests step (success) 07:53:24 INFO - Running post-run listener: _resource_record_post_run 07:53:24 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 921600; Write bytes: 659068416; Read time: 11; Write time: 1993 07:53:24 INFO - TinderboxPrint: CPU usage
54.5% 07:53:24 INFO - TinderboxPrint: I/O read bytes / time
921,600 / 11 07:53:24 INFO - TinderboxPrint: I/O write bytes / time
659,068,416 / 1,993 07:53:24 INFO - TinderboxPrint: CPU idle
2,206.7 (45.5%) 07:53:24 INFO - TinderboxPrint: CPU system
981.3 (20.3%) 07:53:24 INFO - TinderboxPrint: CPU user
1,657.8 (34.2%) 07:53:24 INFO - TinderboxPrint: Swap in / out
349,556,736 / 0 07:53:24 INFO - install - Wall time: 31s; CPU: 55.0%; Read bytes: 345625088; Write bytes: 345888768; Read time: 26807; Write time: 766 07:53:24 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 917504; Write bytes: 306036224; Read time: 11; Write time: 1196 07:53:24 INFO - Running post-run listener: _upload_blobber_files 07:53:24 INFO - Blob upload gear active. 07:53:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:53:24 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 07:53:24 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'] 07:53:24 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 07:53:24 INFO - (blobuploader) - INFO - Open directory for files ... 07:53:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:53:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:53:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:53:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:53:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:53:25 INFO - (blobuploader) - INFO - Done attempting. 07:53:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:53:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:53:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:53:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:53:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:53:26 INFO - (blobuploader) - INFO - Done attempting. 07:53:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:53:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:53:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:53:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:53:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:53:29 INFO - (blobuploader) - INFO - Done attempting. 07:53:29 INFO - (blobuploader) - INFO - Iteration through files over. 07:53:29 INFO - Return code: 0 07:53:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:53:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:53:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f672a1176de66a837a7899e32526f3e34095eb4c25bd80343647454b86d5f79b79871432020c776627101c0a023cff53d8cc8d480aa134c5a6f1d51560c1a9a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eadd03caa56093dc8872729dd95adb2ef58c530060acc05933f05c544eac51e5b09c9a4d503cdc525087f2686b2cc6231ee6a8b08c9821e2bf175e16381fb48a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf5074a3fe4c13cb5e59d8703b241ab22305789db84d2ddd249ab5fc37628b16376f301d30d148b4f1f0a93aec6849d6b79614ad00f747b8cf98243e682ce80e"} 07:53:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:53:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:53:29 INFO - Contents: 07:53:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f672a1176de66a837a7899e32526f3e34095eb4c25bd80343647454b86d5f79b79871432020c776627101c0a023cff53d8cc8d480aa134c5a6f1d51560c1a9a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eadd03caa56093dc8872729dd95adb2ef58c530060acc05933f05c544eac51e5b09c9a4d503cdc525087f2686b2cc6231ee6a8b08c9821e2bf175e16381fb48a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf5074a3fe4c13cb5e59d8703b241ab22305789db84d2ddd249ab5fc37628b16376f301d30d148b4f1f0a93aec6849d6b79614ad00f747b8cf98243e682ce80e"} 07:53:29 INFO - Running post-run listener: copy_logs_to_upload_dir 07:53:29 INFO - Copying logs to upload dir... 07:53:29 INFO - mkdir: /builds/slave/test/build/upload/logs 07:53:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.320359 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-12-16 07:53:29.559824) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-16 07:53:29.563396) ========= 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.R4LlZCmSFP/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.tpsZVJBqOr/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f672a1176de66a837a7899e32526f3e34095eb4c25bd80343647454b86d5f79b79871432020c776627101c0a023cff53d8cc8d480aa134c5a6f1d51560c1a9a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eadd03caa56093dc8872729dd95adb2ef58c530060acc05933f05c544eac51e5b09c9a4d503cdc525087f2686b2cc6231ee6a8b08c9821e2bf175e16381fb48a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf5074a3fe4c13cb5e59d8703b241ab22305789db84d2ddd249ab5fc37628b16376f301d30d148b4f1f0a93aec6849d6b79614ad00f747b8cf98243e682ce80e"} build_url:https://queue.taskcluster.net/v1/task/dP5RjLbPReO2SCiNN0UX5A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011052 build_url: 'https://queue.taskcluster.net/v1/task/dP5RjLbPReO2SCiNN0UX5A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f672a1176de66a837a7899e32526f3e34095eb4c25bd80343647454b86d5f79b79871432020c776627101c0a023cff53d8cc8d480aa134c5a6f1d51560c1a9a0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eadd03caa56093dc8872729dd95adb2ef58c530060acc05933f05c544eac51e5b09c9a4d503cdc525087f2686b2cc6231ee6a8b08c9821e2bf175e16381fb48a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf5074a3fe4c13cb5e59d8703b241ab22305789db84d2ddd249ab5fc37628b16376f301d30d148b4f1f0a93aec6849d6b79614ad00f747b8cf98243e682ce80e"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-16 07:53:29.602808) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 07:53:29.603133) ========= 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.R4LlZCmSFP/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.tpsZVJBqOr/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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.005127 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 07:53:29.651583) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-16 07:53:29.651958) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-16 07:53:29.652432) ========= ========= Total master_lag: 0.19 =========