builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0008 starttime: 1477466806.7 results: success (0) buildid: 20161025221325 builduid: 09ad6336a6c94ab980a15525118f2c43 revision: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 00:26:46.700724) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 00:26:46.701224) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 00:26:46.701571) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 00:26:46.725584) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 00:26:46.726045) ========= 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.UguUGQcNnj/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.MopbDxmpHu/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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-10-26 00:26:46-- 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% 140M=0s 2016-10-26 00:26:47 (140 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.609431 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 00:26:47.356349) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 00:26:47.356719) ========= 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.UguUGQcNnj/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.MopbDxmpHu/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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.019590 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 00:26:47.405620) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 00:26:47.406013) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UguUGQcNnj/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.MopbDxmpHu/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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-10-26 00:26:47,478 truncating revision to first 12 chars 2016-10-26 00:26:47,478 Setting DEBUG logging. 2016-10-26 00:26:47,478 attempt 1/10 2016-10-26 00:26:47,479 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f9f3cc95d728?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-26 00:26:49,147 unpacking tar archive at: fx-team-f9f3cc95d728/testing/mozharness/ program finished with exit code 0 elapsedTime=1.925212 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-26 00:26:49.353494) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 00:26:49.353884) ========= script_repo_revision: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 00:26:49.354316) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 00:26:49.354634) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 00:26:49.372470) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-26 00:26:49.372860) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UguUGQcNnj/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.MopbDxmpHu/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 00:26:49 INFO - MultiFileLogger online at 20161026 00:26:49 in /builds/slave/test 00:26:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 00:26:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:26:49 INFO - {'append_to_log': False, 00:26:49 INFO - 'base_work_dir': '/builds/slave/test', 00:26:49 INFO - 'blob_upload_branch': 'Fx-Team', 00:26:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:26:49 INFO - 'branch': 'Fx-Team', 00:26:49 INFO - 'buildbot_json_path': 'buildprops.json', 00:26:49 INFO - 'config_files': ('talos/mac_config.py',), 00:26:49 INFO - 'default_actions': ('clobber', 00:26:49 INFO - 'read-buildbot-config', 00:26:49 INFO - 'download-and-extract', 00:26:49 INFO - 'populate-webroot', 00:26:49 INFO - 'create-virtualenv', 00:26:49 INFO - 'install', 00:26:49 INFO - 'run-tests'), 00:26:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:26:49 INFO - 'download_minidump_stackwalk': True, 00:26:49 INFO - 'download_symbols': 'ondemand', 00:26:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:26:49 INFO - 'tooltool.py': '/tools/tooltool.py', 00:26:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:26:49 INFO - '/tools/misc-python/virtualenv.py')}, 00:26:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:26:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:26:49 INFO - 'installer_path': 'installer.exe', 00:26:49 INFO - 'log_level': 'info', 00:26:49 INFO - 'log_name': 'talos', 00:26:49 INFO - 'log_to_console': True, 00:26:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:26:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:26:49 INFO - 'opt_config_files': (), 00:26:49 INFO - 'pip_index': False, 00:26:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:26:49 INFO - 'cmd': ('bash', 00:26:49 INFO - '-c', 00:26:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:26:49 INFO - 'enabled': True, 00:26:49 INFO - 'halt_on_failure': False, 00:26:49 INFO - 'name': 'check_screen_resolution'},), 00:26:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:26:49 INFO - 'cmd': ('bash', 00:26:49 INFO - '-c', 00:26:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:26:49 INFO - 'enabled': True, 00:26:49 INFO - 'halt_on_failure': False, 00:26:49 INFO - 'name': 'check_screen_resolution'},), 00:26:49 INFO - 'run_cmd_checks_enabled': True, 00:26:49 INFO - 'sps_profile': False, 00:26:49 INFO - 'sps_profile_interval': 0, 00:26:49 INFO - 'suite': 'dromaeojs', 00:26:49 INFO - 'system_bits': '32', 00:26:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:26:49 INFO - 'title': 't-yosemite-r7-0008', 00:26:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:26:49 INFO - 'use_talos_json': True, 00:26:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:26:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:26:49 INFO - 'work_dir': 'build'} 00:26:49 INFO - [mozharness: 2016-10-26 07:26:49.574286Z] Running clobber step. 00:26:49 INFO - Running pre-action listener: _resource_record_pre_action 00:26:49 INFO - Running main action method: clobber 00:26:49 INFO - rmtree: /builds/slave/test/build 00:26:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:26:51 INFO - Running post-action listener: _resource_record_post_action 00:26:51 INFO - [mozharness: 2016-10-26 07:26:51.271223Z] Finished clobber step (success) 00:26:51 INFO - [mozharness: 2016-10-26 07:26:51.271362Z] Running read-buildbot-config step. 00:26:51 INFO - Running pre-action listener: _resource_record_pre_action 00:26:51 INFO - Running main action method: read_buildbot_config 00:26:51 INFO - Using buildbot properties: 00:26:51 INFO - { 00:26:51 INFO - "project": "", 00:26:51 INFO - "product": "firefox", 00:26:51 INFO - "script_repo_revision": "production", 00:26:51 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 00:26:51 INFO - "repository": "", 00:26:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 00:26:51 INFO - "buildid": "20161025221325", 00:26:51 INFO - "pgo_build": "False", 00:26:51 INFO - "basedir": "/builds/slave/test", 00:26:51 INFO - "buildnumber": 173, 00:26:51 INFO - "slavename": "t-yosemite-r7-0008", 00:26:51 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 00:26:51 INFO - "platform": "yosemite_r7", 00:26:51 INFO - "scheduler": "tests-fx-team-macosx64-talos", 00:26:51 INFO - "branch": "fx-team", 00:26:51 INFO - "repo_path": "integration/fx-team", 00:26:51 INFO - "revision": "f9f3cc95d7282f1fd83f66dd74acbcdbfe821915", 00:26:51 INFO - "stage_platform": "macosx64", 00:26:51 INFO - "builduid": "09ad6336a6c94ab980a15525118f2c43", 00:26:51 INFO - "slavebuilddir": "test" 00:26:51 INFO - } 00:26:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/HtltD5jAS0qPIKFv1Rn9JQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 00:26:51 INFO - Running post-action listener: _resource_record_post_action 00:26:51 INFO - [mozharness: 2016-10-26 07:26:51.274994Z] Finished read-buildbot-config step (success) 00:26:51 INFO - [mozharness: 2016-10-26 07:26:51.275114Z] Running download-and-extract step. 00:26:51 INFO - Running pre-action listener: _resource_record_pre_action 00:26:51 INFO - Running main action method: download_and_extract 00:26:51 INFO - mkdir: /builds/slave/test/build/tests 00:26:51 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')]} 00:26:51 INFO - trying https://queue.taskcluster.net/v1/task/HtltD5jAS0qPIKFv1Rn9JQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 00:26:51 INFO - Downloading https://queue.taskcluster.net/v1/task/HtltD5jAS0qPIKFv1Rn9JQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 00:26:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HtltD5jAS0qPIKFv1Rn9JQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 00:26:52 INFO - Downloaded 1199 bytes. 00:26:52 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 00:26:52 INFO - Using the following test package requirements: 00:26:52 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 00:26:52 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:26:52 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 00:26:52 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:26:52 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 00:26:52 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:26:52 INFO - u'jsshell-mac.zip'], 00:26:52 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:26:52 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 00:26:52 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 00:26:52 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:26:52 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 00:26:52 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:26:52 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 00:26:52 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:26:52 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 00:26:52 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:26:52 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 00:26:52 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 00:26:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HtltD5jAS0qPIKFv1Rn9JQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 00:26:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HtltD5jAS0qPIKFv1Rn9JQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:26:52 INFO - Fetch https://queue.taskcluster.net/v1/task/HtltD5jAS0qPIKFv1Rn9JQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 00:26:53 INFO - Http code: 200 00:26:53 INFO - via: 1.1 02192a27c967e955f8c815efa939bfc8.cloudfront.net (CloudFront) 00:26:53 INFO - x-amz-cf-id: XZ6Bc_EHBVwFC54UBjMwHSOr2N7gwN9Z_LQ1tWezKzt8iDxqHGiVFQ== 00:26:53 INFO - x-amz-version-id: IZ8TyIQWYIh8x5pGsR935ZfWU9hVa0KP 00:26:53 INFO - Expected file size: 16438394 00:26:53 INFO - Obtained file size: 16438394 00:27:00 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 00:27:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HtltD5jAS0qPIKFv1Rn9JQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 00:27:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HtltD5jAS0qPIKFv1Rn9JQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:27:00 INFO - Fetch https://queue.taskcluster.net/v1/task/HtltD5jAS0qPIKFv1Rn9JQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 00:27:00 INFO - Http code: 200 00:27:00 INFO - via: 1.1 6e65abb04cb818a6ec78111935b507f7.cloudfront.net (CloudFront) 00:27:00 INFO - x-amz-cf-id: vV2TOqDCvX6bB1VylDP2hDdyl7amJhnnlCnWOV_y7XgXw92uAdU2lQ== 00:27:00 INFO - x-amz-version-id: IZ8TyIQWYIh8x5pGsR935ZfWU9hVa0KP 00:27:01 INFO - Expected file size: 16438394 00:27:01 INFO - Obtained file size: 16438394 00:27:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HtltD5jAS0qPIKFv1Rn9JQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 00:27:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HtltD5jAS0qPIKFv1Rn9JQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 00:27:07 INFO - Fetch https://queue.taskcluster.net/v1/task/HtltD5jAS0qPIKFv1Rn9JQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 00:27:09 INFO - Http code: 200 00:27:09 INFO - via: 1.1 55676da1e5c0a9c4e60a94a95b01dc04.cloudfront.net (CloudFront) 00:27:09 INFO - x-amz-cf-id: ikHDodC_knQAsTjiuF9EX2W9M_OkO_MFHKVHxZgLCUcejnbqo3Udig== 00:27:09 INFO - x-amz-version-id: c_z94rUFkydbkb4jPdns9ptt9kA_Q4.T 00:27:10 INFO - Expected file size: 14409028 00:27:10 INFO - Obtained file size: 14409028 00:27:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:27:10 INFO - trying https://queue.taskcluster.net/v1/task/HtltD5jAS0qPIKFv1Rn9JQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 00:27:10 INFO - Downloading https://queue.taskcluster.net/v1/task/HtltD5jAS0qPIKFv1Rn9JQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 00:27:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HtltD5jAS0qPIKFv1Rn9JQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 00:27:13 INFO - Downloaded 111653951 bytes. 00:27:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HtltD5jAS0qPIKFv1Rn9JQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 00:27:13 INFO - mkdir: /builds/slave/test/properties 00:27:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:27:13 INFO - Writing to file /builds/slave/test/properties/build_url 00:27:13 INFO - Contents: 00:27:13 INFO - build_url:https://queue.taskcluster.net/v1/task/HtltD5jAS0qPIKFv1Rn9JQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 00:27:13 INFO - Running post-action listener: _resource_record_post_action 00:27:13 INFO - Running post-action listener: set_extra_try_arguments 00:27:13 INFO - [mozharness: 2016-10-26 07:27:13.864414Z] Finished download-and-extract step (success) 00:27:13 INFO - [mozharness: 2016-10-26 07:27:13.864516Z] Running populate-webroot step. 00:27:13 INFO - Running pre-action listener: _resource_record_pre_action 00:27:13 INFO - Running main action method: populate_webroot 00:27:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:27:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:27:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:27:13 INFO - '--tppagecycles', 00:27:13 INFO - '7'], 00:27:13 INFO - 'tests': ['tsvgm']}}, 00:27:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:27:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:27:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:27:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:27:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:27:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:27:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:27:13 INFO - 'talos_options': ['--disable-e10s'], 00:27:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:27:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:27:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:27:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:27:13 INFO - 'talos_options': ['--disable-e10s'], 00:27:13 INFO - 'tests': ['damp', 'tps']}, 00:27:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:27:13 INFO - 'tests': ['damp', 'tps']}, 00:27:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:27:13 INFO - 'tests': ['dromaeo_dom']}, 00:27:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:27:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:27:13 INFO - 'tests': ['basic_compositor_video']}, 00:27:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:27:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:27:13 INFO - 'tests': ['a11yr', 00:27:13 INFO - 'ts_paint', 00:27:13 INFO - 'tpaint', 00:27:13 INFO - 'sessionrestore', 00:27:13 INFO - 'sessionrestore_no_auto_restore', 00:27:13 INFO - 'tabpaint']}, 00:27:13 INFO - 'other-e10s': {'tests': ['a11yr', 00:27:13 INFO - 'ts_paint', 00:27:13 INFO - 'tpaint', 00:27:13 INFO - 'sessionrestore', 00:27:13 INFO - 'sessionrestore_no_auto_restore', 00:27:13 INFO - 'tabpaint']}, 00:27:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:27:13 INFO - 'ts_paint', 00:27:13 INFO - 'tpaint', 00:27:13 INFO - 'sessionrestore', 00:27:13 INFO - 'sessionrestore_no_auto_restore', 00:27:13 INFO - 'tabpaint']}, 00:27:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:27:13 INFO - 'ts_paint', 00:27:13 INFO - 'tpaint', 00:27:13 INFO - 'sessionrestore', 00:27:13 INFO - 'sessionrestore_no_auto_restore', 00:27:13 INFO - 'tabpaint']}, 00:27:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:27:13 INFO - 'tests': ['a11yr', 00:27:13 INFO - 'ts_paint', 00:27:13 INFO - 'tpaint', 00:27:13 INFO - 'sessionrestore', 00:27:13 INFO - 'sessionrestore_no_auto_restore', 00:27:13 INFO - 'tabpaint']}, 00:27:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:27:13 INFO - 'tests': ['a11yr', 00:27:13 INFO - 'ts_paint', 00:27:13 INFO - 'tpaint', 00:27:13 INFO - 'sessionrestore', 00:27:13 INFO - 'sessionrestore_no_auto_restore', 00:27:13 INFO - 'tabpaint']}, 00:27:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:27:13 INFO - 'tests': ['tsvgx', 00:27:13 INFO - 'tsvgr_opacity', 00:27:13 INFO - 'tart', 00:27:13 INFO - 'tscrollx', 00:27:13 INFO - 'cart']}, 00:27:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:27:13 INFO - 'tsvgr_opacity', 00:27:13 INFO - 'tart', 00:27:13 INFO - 'tscrollx', 00:27:13 INFO - 'cart']}, 00:27:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:27:13 INFO - 'talos_options': ['--disable-e10s'], 00:27:13 INFO - 'tests': ['tp5o']}, 00:27:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:27:13 INFO - 'tests': ['tp5o']}, 00:27:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:27:13 INFO - 'talos_options': ['--disable-e10s', 00:27:13 INFO - '--xperf_path', 00:27:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:27:13 INFO - 'tests': ['tp5n']}, 00:27:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:27:13 INFO - 'talos_options': ['--xperf_path', 00:27:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:27:13 INFO - 'tests': ['tp5n']}}, 00:27:13 INFO - 'talos.zip': {'path': '', 00:27:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:27:13 INFO - Running post-action listener: _resource_record_post_action 00:27:13 INFO - [mozharness: 2016-10-26 07:27:13.883931Z] Finished populate-webroot step (success) 00:27:13 INFO - [mozharness: 2016-10-26 07:27:13.884069Z] Running create-virtualenv step. 00:27:13 INFO - Running pre-action listener: _resource_record_pre_action 00:27:13 INFO - Running main action method: create_virtualenv 00:27:13 INFO - Creating virtualenv /builds/slave/test/build/venv 00:27:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 00:27:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:27:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:27:14 INFO - Using real prefix '/tools/python27' 00:27:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:27:14 INFO - Installing distribute.............................................................................................................................................................................................done. 00:27:17 INFO - Installing pip.................done. 00:27:17 INFO - Return code: 0 00:27:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:27:17 INFO - Reading from file tmpfile_stdout 00:27:17 INFO - Output received: 00:27:17 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) 00:27:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:27:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1059bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105935570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7aa5ce940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057d3d30>, '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 0x1055f9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057cbb20>, '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.UguUGQcNnj/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.MopbDxmpHu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 00:27:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:27:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UguUGQcNnj/Render', 00:27:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:27:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:27:17 INFO - 'HOME': '/Users/cltbld', 00:27:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:27:17 INFO - 'LOGNAME': 'cltbld', 00:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:17 INFO - 'MOZ_NO_REMOTE': '1', 00:27:17 INFO - 'NO_EM_RESTART': '1', 00:27:17 INFO - 'PAGER': '/bin/cat', 00:27:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:27:17 INFO - 'PWD': '/builds/slave/test', 00:27:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:27:17 INFO - 'SHELL': '/bin/bash', 00:27:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MopbDxmpHu/Listeners', 00:27:17 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 00:27:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:27:17 INFO - 'USER': 'cltbld', 00:27:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:27:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:17 INFO - 'XPC_FLAGS': '0x0', 00:27:17 INFO - 'XPC_SERVICE_NAME': '0', 00:27:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:27:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:18 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 00:27:18 INFO - Cleaning up... 00:27:18 INFO - Return code: 0 00:27:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:27:18 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')]} 00:27:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:18 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')]} 00:27:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:18 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 0x1059bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105935570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7aa5ce940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057d3d30>, '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 0x1055f9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057cbb20>, '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.UguUGQcNnj/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.MopbDxmpHu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 00:27:18 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 00:27:18 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 00:27:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UguUGQcNnj/Render', 00:27:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:27:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:27:18 INFO - 'HOME': '/Users/cltbld', 00:27:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:27:18 INFO - 'LOGNAME': 'cltbld', 00:27:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:18 INFO - 'MOZ_NO_REMOTE': '1', 00:27:18 INFO - 'NO_EM_RESTART': '1', 00:27:18 INFO - 'PAGER': '/bin/cat', 00:27:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:27:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:27:18 INFO - 'PWD': '/builds/slave/test', 00:27:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:27:18 INFO - 'SHELL': '/bin/bash', 00:27:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MopbDxmpHu/Listeners', 00:27:18 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 00:27:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:27:18 INFO - 'USER': 'cltbld', 00:27:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:27:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:27:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:18 INFO - 'XPC_FLAGS': '0x0', 00:27:18 INFO - 'XPC_SERVICE_NAME': '0', 00:27:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:27:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:18 INFO - Downloading/unpacking psutil>=3.1.1 00:27:18 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 00:27:18 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 00:27:18 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 00:27:18 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 00:27:18 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 00:27:18 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 00:27:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:27:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:27:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:27:22 INFO - Installing collected packages: psutil 00:27:22 INFO - Running setup.py install for psutil 00:27:22 INFO - building 'psutil._psutil_osx' extension 00:27:22 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 00:27:22 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 00:27:22 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 00:27:22 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 00:27:22 INFO - building 'psutil._psutil_posix' extension 00:27:22 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 00:27:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:27:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:27:22 INFO - ^ 00:27:22 INFO - 1 warning generated. 00:27:22 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 00:27:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:27:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:27:22 INFO - Successfully installed psutil 00:27:22 INFO - Cleaning up... 00:27:23 INFO - Return code: 0 00:27:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:27:23 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')]} 00:27:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:23 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')]} 00:27:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:23 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 0x1059bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105935570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7aa5ce940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057d3d30>, '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 0x1055f9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057cbb20>, '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.UguUGQcNnj/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.MopbDxmpHu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 00:27:23 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 00:27:23 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 00:27:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UguUGQcNnj/Render', 00:27:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:27:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:27:23 INFO - 'HOME': '/Users/cltbld', 00:27:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:27:23 INFO - 'LOGNAME': 'cltbld', 00:27:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:23 INFO - 'MOZ_NO_REMOTE': '1', 00:27:23 INFO - 'NO_EM_RESTART': '1', 00:27:23 INFO - 'PAGER': '/bin/cat', 00:27:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:27:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:27:23 INFO - 'PWD': '/builds/slave/test', 00:27:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:27:23 INFO - 'SHELL': '/bin/bash', 00:27:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MopbDxmpHu/Listeners', 00:27:23 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 00:27:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:27:23 INFO - 'USER': 'cltbld', 00:27:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:27:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:27:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:23 INFO - 'XPC_FLAGS': '0x0', 00:27:23 INFO - 'XPC_SERVICE_NAME': '0', 00:27:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:27:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:27:23 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 00:27:23 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 00:27:23 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 00:27:23 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 00:27:23 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 00:27:23 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 00:27:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:27:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:27:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:27:25 INFO - Installing collected packages: mozsystemmonitor 00:27:25 INFO - Running setup.py install for mozsystemmonitor 00:27:26 INFO - Successfully installed mozsystemmonitor 00:27:26 INFO - Cleaning up... 00:27:26 INFO - Return code: 0 00:27:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:27:26 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')]} 00:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:26 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')]} 00:27:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:26 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 0x1059bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105935570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7aa5ce940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057d3d30>, '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 0x1055f9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057cbb20>, '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.UguUGQcNnj/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.MopbDxmpHu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 00:27:26 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 00:27:26 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 00:27:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UguUGQcNnj/Render', 00:27:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:27:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:27:26 INFO - 'HOME': '/Users/cltbld', 00:27:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:27:26 INFO - 'LOGNAME': 'cltbld', 00:27:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:26 INFO - 'MOZ_NO_REMOTE': '1', 00:27:26 INFO - 'NO_EM_RESTART': '1', 00:27:26 INFO - 'PAGER': '/bin/cat', 00:27:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:27:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:27:26 INFO - 'PWD': '/builds/slave/test', 00:27:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:27:26 INFO - 'SHELL': '/bin/bash', 00:27:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MopbDxmpHu/Listeners', 00:27:26 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 00:27:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:27:26 INFO - 'USER': 'cltbld', 00:27:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:27:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:27:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:26 INFO - 'XPC_FLAGS': '0x0', 00:27:26 INFO - 'XPC_SERVICE_NAME': '0', 00:27:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:27:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:26 INFO - Downloading/unpacking jsonschema==2.5.1 00:27:26 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 00:27:26 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 00:27:26 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 00:27:26 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 00:27:26 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 00:27:26 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 00:27:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:27:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:29 INFO - Downloading functools32-3.2.3-2.tar.gz 00:27:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:27:29 INFO - warning: no files found matching '*.txt' 00:27:29 INFO - no previously-included directories found matching 'build' 00:27:29 INFO - no previously-included directories found matching 'dist' 00:27:29 INFO - no previously-included directories found matching '.git*' 00:27:29 INFO - Installing collected packages: jsonschema, functools32 00:27:29 INFO - Running setup.py install for functools32 00:27:29 INFO - warning: no files found matching '*.txt' 00:27:29 INFO - no previously-included directories found matching 'build' 00:27:29 INFO - no previously-included directories found matching 'dist' 00:27:29 INFO - no previously-included directories found matching '.git*' 00:27:29 INFO - Successfully installed jsonschema functools32 00:27:29 INFO - Cleaning up... 00:27:29 INFO - Return code: 0 00:27:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:27:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:27:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:27:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1059bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105935570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7aa5ce940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057d3d30>, '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 0x1055f9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057cbb20>, '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.UguUGQcNnj/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.MopbDxmpHu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 00:27:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:27:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 00:27:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UguUGQcNnj/Render', 00:27:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:27:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:27:29 INFO - 'HOME': '/Users/cltbld', 00:27:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:27:29 INFO - 'LOGNAME': 'cltbld', 00:27:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:29 INFO - 'MOZ_NO_REMOTE': '1', 00:27:29 INFO - 'NO_EM_RESTART': '1', 00:27:29 INFO - 'PAGER': '/bin/cat', 00:27:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:27:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:27:29 INFO - 'PWD': '/builds/slave/test', 00:27:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:27:29 INFO - 'SHELL': '/bin/bash', 00:27:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MopbDxmpHu/Listeners', 00:27:29 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 00:27:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:27:29 INFO - 'USER': 'cltbld', 00:27:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:27:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:27:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:29 INFO - 'XPC_FLAGS': '0x0', 00:27:29 INFO - 'XPC_SERVICE_NAME': '0', 00:27:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:27:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:27:29 INFO - Cleaning up... 00:27:29 INFO - Return code: 0 00:27:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:27:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:27:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:27:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1059bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105935570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7aa5ce940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057d3d30>, '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 0x1055f9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057cbb20>, '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.UguUGQcNnj/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.MopbDxmpHu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 00:27:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:27:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:27:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UguUGQcNnj/Render', 00:27:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:27:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:27:29 INFO - 'HOME': '/Users/cltbld', 00:27:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:27:29 INFO - 'LOGNAME': 'cltbld', 00:27:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:29 INFO - 'MOZ_NO_REMOTE': '1', 00:27:29 INFO - 'NO_EM_RESTART': '1', 00:27:29 INFO - 'PAGER': '/bin/cat', 00:27:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:27:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:27:29 INFO - 'PWD': '/builds/slave/test', 00:27:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:27:29 INFO - 'SHELL': '/bin/bash', 00:27:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MopbDxmpHu/Listeners', 00:27:29 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 00:27:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:27:29 INFO - 'USER': 'cltbld', 00:27:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:27:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:27:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:29 INFO - 'XPC_FLAGS': '0x0', 00:27:29 INFO - 'XPC_SERVICE_NAME': '0', 00:27:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:27:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:30 INFO - Downloading/unpacking blobuploader==1.2.4 00:27:30 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 00:27:30 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 00:27:30 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 00:27:30 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 00:27:30 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 00:27:30 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 00:27:32 INFO - Downloading blobuploader-1.2.4.tar.gz 00:27:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:27:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:27:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:27:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:27:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:33 INFO - Downloading docopt-0.6.1.tar.gz 00:27:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:27:33 INFO - Installing collected packages: blobuploader, requests, docopt 00:27:33 INFO - Running setup.py install for blobuploader 00:27:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:27:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:27:34 INFO - Running setup.py install for requests 00:27:34 INFO - Running setup.py install for docopt 00:27:34 INFO - Successfully installed blobuploader requests docopt 00:27:34 INFO - Cleaning up... 00:27:34 INFO - Return code: 0 00:27:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1059bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105935570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7aa5ce940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057d3d30>, '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 0x1055f9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057cbb20>, '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.UguUGQcNnj/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.MopbDxmpHu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 00:27:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:27:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:27:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UguUGQcNnj/Render', 00:27:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:27:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:27:34 INFO - 'HOME': '/Users/cltbld', 00:27:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:27:34 INFO - 'LOGNAME': 'cltbld', 00:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:34 INFO - 'MOZ_NO_REMOTE': '1', 00:27:34 INFO - 'NO_EM_RESTART': '1', 00:27:34 INFO - 'PAGER': '/bin/cat', 00:27:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:27:34 INFO - 'PWD': '/builds/slave/test', 00:27:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:27:34 INFO - 'SHELL': '/bin/bash', 00:27:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MopbDxmpHu/Listeners', 00:27:34 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 00:27:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:27:34 INFO - 'USER': 'cltbld', 00:27:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:27:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:34 INFO - 'XPC_FLAGS': '0x0', 00:27:34 INFO - 'XPC_SERVICE_NAME': '0', 00:27:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:27:34 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-zWaBjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:27:35 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-2Ryxh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:27:35 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-t5YUR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:27:35 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-0mIPUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:27:35 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-WIeLI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:27:35 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-bq4Ijd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:27:35 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-JEMHB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:27:35 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-IsKDIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:27:35 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-8dJn75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:27:35 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-dphLSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:27:36 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-pVr90Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:27:36 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-iljZGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:27:36 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-fpcSLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:27:36 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-L1HiOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:27:36 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-yY1H8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:27:36 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-dpSX6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:27:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:27:36 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-ffJ0cA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:27:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:27:36 INFO - Running setup.py install for manifestparser 00:27:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:27:36 INFO - Running setup.py install for mozcrash 00:27:37 INFO - Running setup.py install for mozdebug 00:27:37 INFO - Running setup.py install for mozdevice 00:27:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:27:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:27:37 INFO - Running setup.py install for mozfile 00:27:37 INFO - Running setup.py install for mozhttpd 00:27:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:27:37 INFO - Running setup.py install for mozinfo 00:27:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:27:37 INFO - Running setup.py install for mozInstall 00:27:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:27:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:27:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:27:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:27:37 INFO - Running setup.py install for mozleak 00:27:38 INFO - Running setup.py install for mozlog 00:27:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:27:38 INFO - Running setup.py install for moznetwork 00:27:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:27:38 INFO - Running setup.py install for mozprocess 00:27:38 INFO - Running setup.py install for mozprofile 00:27:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:27:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:27:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:27:38 INFO - Running setup.py install for mozrunner 00:27:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:27:38 INFO - Running setup.py install for mozscreenshot 00:27:39 INFO - Running setup.py install for moztest 00:27:39 INFO - Running setup.py install for mozversion 00:27:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:27:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:27:39 INFO - Cleaning up... 00:27:39 INFO - Return code: 0 00:27:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:27:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:27:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1059bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105935570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7aa5ce940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057d3d30>, '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 0x1055f9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057cbb20>, '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.UguUGQcNnj/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.MopbDxmpHu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 00:27:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:27:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:27:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UguUGQcNnj/Render', 00:27:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:27:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:27:39 INFO - 'HOME': '/Users/cltbld', 00:27:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:27:39 INFO - 'LOGNAME': 'cltbld', 00:27:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:39 INFO - 'MOZ_NO_REMOTE': '1', 00:27:39 INFO - 'NO_EM_RESTART': '1', 00:27:39 INFO - 'PAGER': '/bin/cat', 00:27:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:27:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:27:39 INFO - 'PWD': '/builds/slave/test', 00:27:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:27:39 INFO - 'SHELL': '/bin/bash', 00:27:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MopbDxmpHu/Listeners', 00:27:39 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 00:27:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:27:39 INFO - 'USER': 'cltbld', 00:27:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:27:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:27:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:39 INFO - 'XPC_FLAGS': '0x0', 00:27:39 INFO - 'XPC_SERVICE_NAME': '0', 00:27:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:27:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:27:39 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-ZWAPFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:27:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 00:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:27:39 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-jloX7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:27:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:27:39 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-WQjSSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:27:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:27:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:27:39 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-wxTqwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:27:40 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)) 00:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:27:40 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-CUpv6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:27:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 00:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:27:40 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-Ve8V5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:27:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 00:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:27:40 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-V4tGmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:27:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 00:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:27:40 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-JobFAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:27:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 00:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:27:40 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-TNaHdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:27:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 00:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:27:40 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-jtrVuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:27:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:27:40 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-NCsvBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:27:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 00:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:27:40 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-Ng_VDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:27:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 00:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:27:40 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-tRaNEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:27:41 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)) 00:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:27:41 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-s7RXHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:27:41 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-Kmn3b4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 00:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:27:41 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-GZA0qL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 00:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:27:41 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-qNXl6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 00:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:27:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:43 INFO - Downloading blessings-1.6.tar.gz 00:27:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:27:44 INFO - Installing collected packages: blessings 00:27:44 INFO - Running setup.py install for blessings 00:27:44 INFO - Successfully installed blessings 00:27:44 INFO - Cleaning up... 00:27:44 INFO - Return code: 0 00:27:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:27:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:27:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:27:44 INFO - Reading from file tmpfile_stdout 00:27:44 INFO - Current package versions: 00:27:44 INFO - blessings == 1.6 00:27:44 INFO - blobuploader == 1.2.4 00:27:44 INFO - docopt == 0.6.1 00:27:44 INFO - functools32 == 3.2.3-2 00:27:44 INFO - jsonschema == 2.5.1 00:27:44 INFO - manifestparser == 1.1 00:27:44 INFO - mozInstall == 1.12 00:27:44 INFO - mozcrash == 0.17 00:27:44 INFO - mozdebug == 0.1 00:27:44 INFO - mozdevice == 0.48 00:27:44 INFO - mozfile == 1.2 00:27:44 INFO - mozhttpd == 0.7 00:27:44 INFO - mozinfo == 0.9 00:27:44 INFO - mozleak == 0.1 00:27:44 INFO - mozlog == 3.4 00:27:44 INFO - moznetwork == 0.27 00:27:44 INFO - mozprocess == 0.23 00:27:44 INFO - mozprofile == 0.28 00:27:44 INFO - mozrunner == 6.12 00:27:44 INFO - mozscreenshot == 0.1 00:27:44 INFO - mozsystemmonitor == 0.3 00:27:44 INFO - moztest == 0.7 00:27:44 INFO - mozversion == 1.4 00:27:44 INFO - psutil == 3.1.1 00:27:44 INFO - requests == 1.2.3 00:27:44 INFO - wsgiref == 0.1.2 00:27:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:27:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:27:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:44 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 0x1059bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105935570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7aa5ce940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057d3d30>, '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 0x1055f9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057cbb20>, '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.UguUGQcNnj/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.MopbDxmpHu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 00:27:44 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 00:27:44 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 00:27:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UguUGQcNnj/Render', 00:27:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:27:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:27:44 INFO - 'HOME': '/Users/cltbld', 00:27:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:27:44 INFO - 'LOGNAME': 'cltbld', 00:27:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:44 INFO - 'MOZ_NO_REMOTE': '1', 00:27:44 INFO - 'NO_EM_RESTART': '1', 00:27:44 INFO - 'PAGER': '/bin/cat', 00:27:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:27:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:27:44 INFO - 'PWD': '/builds/slave/test', 00:27:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:27:44 INFO - 'SHELL': '/bin/bash', 00:27:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MopbDxmpHu/Listeners', 00:27:44 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 00:27:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:27:44 INFO - 'USER': 'cltbld', 00:27:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:27:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:27:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:44 INFO - 'XPC_FLAGS': '0x0', 00:27:44 INFO - 'XPC_SERVICE_NAME': '0', 00:27:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:27:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:44 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)) 00:27:44 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)) 00:27:44 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)) 00:27:44 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)) 00:27:44 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)) 00:27:44 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)) 00:27:44 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)) 00:27:44 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)) 00:27:44 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)) 00:27:44 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)) 00:27:44 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)) 00:27:44 INFO - Cleaning up... 00:27:44 INFO - Return code: 0 00:27:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:27:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:27:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1059bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105935570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7aa5ce940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057d3d30>, '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 0x1055f9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057cbb20>, '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.UguUGQcNnj/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.MopbDxmpHu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 00:27: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', 'jsonschema'] in /builds/slave/test/build 00:27: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 jsonschema 00:27:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UguUGQcNnj/Render', 00:27:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:27:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:27:44 INFO - 'HOME': '/Users/cltbld', 00:27:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:27:44 INFO - 'LOGNAME': 'cltbld', 00:27:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:44 INFO - 'MOZ_NO_REMOTE': '1', 00:27:44 INFO - 'NO_EM_RESTART': '1', 00:27:44 INFO - 'PAGER': '/bin/cat', 00:27:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:27:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:27:44 INFO - 'PWD': '/builds/slave/test', 00:27:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:27:44 INFO - 'SHELL': '/bin/bash', 00:27:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MopbDxmpHu/Listeners', 00:27:44 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 00:27:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:27:44 INFO - 'USER': 'cltbld', 00:27:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:27:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:27:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:44 INFO - 'XPC_FLAGS': '0x0', 00:27:44 INFO - 'XPC_SERVICE_NAME': '0', 00:27:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:27:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:27:45 INFO - Cleaning up... 00:27:45 INFO - Return code: 0 00:27:45 INFO - Running post-action listener: _resource_record_post_action 00:27:45 INFO - Running post-action listener: _start_resource_monitoring 00:27:45 INFO - Starting resource monitoring. 00:27:45 INFO - [mozharness: 2016-10-26 07:27:45.137051Z] Finished create-virtualenv step (success) 00:27:45 INFO - [mozharness: 2016-10-26 07:27:45.138166Z] Running install step. 00:27:45 INFO - Running pre-action listener: _resource_record_pre_action 00:27:45 INFO - Running main action method: install 00:27:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:27:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:27:45 INFO - Reading from file tmpfile_stdout 00:27:45 INFO - Detecting whether we're running mozinstall >=1.0... 00:27:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:27:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:27:45 INFO - Reading from file tmpfile_stdout 00:27:45 INFO - Output received: 00:27:45 INFO - Usage: mozinstall [options] installer 00:27:45 INFO - Options: 00:27:45 INFO - -h, --help show this help message and exit 00:27:45 INFO - -d DEST, --destination=DEST 00:27:45 INFO - Directory to install application into. [default: 00:27:45 INFO - "/builds/slave/test"] 00:27:45 INFO - --app=APP Application being installed. [default: firefox] 00:27:45 INFO - mkdir: /builds/slave/test/build/application 00:27:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 00:27:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 00:28:19 INFO - Reading from file tmpfile_stdout 00:28:19 INFO - Output received: 00:28:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 00:28:19 INFO - Running post-action listener: _resource_record_post_action 00:28:19 INFO - [mozharness: 2016-10-26 07:28:19.712859Z] Finished install step (success) 00:28:19 INFO - [mozharness: 2016-10-26 07:28:19.713015Z] Running run-tests step. 00:28:19 INFO - Running pre-action listener: _resource_record_pre_action 00:28:19 INFO - Running main action method: run_tests 00:28:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:28:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:28:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:28:19 INFO - 2016-10-26 00:28:19.728 screenresolution[2305:286052] starting screenresolution argv=screenresolution get 00:28:19 INFO - 2016-10-26 00:28:19.730 screenresolution[2305:286052] Display 0: 1600x1200x32@60 00:28:19 INFO - 2016-10-26 00:28:19.737 screenresolution[2306:286055] starting screenresolution argv=screenresolution list 00:28:19 INFO - Available Modes on Display 0 00:28:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:28:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:28:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:28:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:28:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:28:19 INFO - Intel Iris: 00:28:19 INFO - Chipset Model: Intel Iris 00:28:19 INFO - Type: GPU 00:28:19 INFO - Bus: Built-In 00:28:19 INFO - VRAM (Dynamic, Max): 1536 MB 00:28:19 INFO - Vendor: Intel (0x8086) 00:28:19 INFO - Device ID: 0x0a2e 00:28:19 INFO - Revision ID: 0x0009 00:28:19 INFO - Displays: 00:28:19 INFO - Display: 00:28:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:28:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:28:19 INFO - Display Serial Number: 1600x1200 60 00:28:19 INFO - Main Display: Yes 00:28:19 INFO - Mirror: Off 00:28:19 INFO - Online: Yes 00:28:19 INFO - Rotation: Supported 00:28:19 INFO - Return code: 0 00:28:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:28:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:28:19 INFO - Python 2.7.3 00:28:19 INFO - Return code: 0 00:28:19 INFO - grabbing minidump binary from tooltool 00:28:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:28:19 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 0x1057d3d30>, '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 0x1055f9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057cbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:28:19 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 00:28:19 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 00:28:19 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 00:28:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:28:20 INFO - Return code: 0 00:28:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:28:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:28:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:28:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:28:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:28:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HtltD5jAS0qPIKFv1Rn9JQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 00:28:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HtltD5jAS0qPIKFv1Rn9JQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 00:28:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UguUGQcNnj/Render', 00:28:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:28:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:28:20 INFO - 'HOME': '/Users/cltbld', 00:28:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:28:20 INFO - 'LOGNAME': 'cltbld', 00:28:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:28:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:28:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:28:20 INFO - 'MOZ_NO_REMOTE': '1', 00:28:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:28:20 INFO - 'NO_EM_RESTART': '1', 00:28:20 INFO - 'PAGER': '/bin/cat', 00:28:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:28:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:28:20 INFO - 'PWD': '/builds/slave/test', 00:28:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:28:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:28:20 INFO - 'SHELL': '/bin/bash', 00:28:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MopbDxmpHu/Listeners', 00:28:20 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 00:28:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:28:20 INFO - 'USER': 'cltbld', 00:28:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:28:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:28:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:28:20 INFO - 'XPC_FLAGS': '0x0', 00:28:20 INFO - 'XPC_SERVICE_NAME': '0', 00:28:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:28:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HtltD5jAS0qPIKFv1Rn9JQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 00:28:20 INFO - mozversion application_buildid: 20161025221325 00:28:20 INFO - mozversion application_changeset: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 00:28:20 INFO - mozversion application_display_name: Nightly 00:28:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:28:20 INFO - mozversion application_name: Firefox 00:28:20 INFO - mozversion application_remotingname: firefox 00:28:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:28:20 INFO - mozversion application_vendor: Mozilla 00:28:20 INFO - mozversion application_version: 52.0a1 00:28:20 INFO - mozversion platform_buildid: 20161025221325 00:28:20 INFO - mozversion platform_changeset: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 00:28:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:28:20 INFO - mozversion platform_version: 52.0a1 00:28:20 INFO - using testdate: 1477466900 00:28:20 INFO - actual date: 1477466900 00:28:20 INFO - starting webserver on 'localhost:51600' 00:28:20 INFO - SUITE-START | Running 2 tests 00:28:20 INFO - TEST-START | dromaeo_css 00:28:20 INFO - operating with platform_type : mac_ 00:28:20 INFO - Initialising browser for dromaeo_css test... 00:28:20 INFO - TEST-INFO | started process 2316 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmpnBGcGg/profile http://localhost:51600/getInfo.html) 00:28:22 INFO - PROCESS | 2316 | __metrics Screen width/height:1600/1200 00:28:22 INFO - PROCESS | 2316 | colorDepth:24 00:28:22 INFO - PROCESS | 2316 | Browser inner width/height: 1024/689 00:28:22 INFO - PROCESS | 2316 | __metrics 00:28:22 INFO - PROCESS | 2316 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:28:22 INFO - PROCESS | 2316 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:28:23 INFO - TEST-INFO | 2316: exit 0 00:28:23 INFO - Browser initialized. 00:28:23 INFO - Running cycle 1/1 for dromaeo_css test... 00:28:23 INFO - TEST-INFO | started process 2318 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmpnBGcGg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:28:35 INFO - PROCESS | 2318 | RSS: Main: 230588416 00:28:35 INFO - PROCESS | 2318 | 00:29:26 INFO - PROCESS | 2318 | 1477466966818 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] 00:31:38 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:51600/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51600/tests/dromaeo/cssquery-ext.html) 00:31:41 INFO - PROCESS | 2318 | RSS: Main: 432365568 00:31:41 INFO - PROCESS | 2318 | 00:34:44 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:51600/tests/dromaeo/cssquery-ext.html (next: http://localhost:51600/tests/dromaeo/cssquery-jquery.html) 00:34:45 INFO - PROCESS | 2318 | RSS: Main: 375934976 00:34:45 INFO - PROCESS | 2318 | 00:37:47 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:51600/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51600/tests/dromaeo/cssquery-mootools.html) 00:37:48 INFO - PROCESS | 2318 | RSS: Main: 346152960 00:37:48 INFO - PROCESS | 2318 | 00:40:50 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:51600/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51600/tests/dromaeo/cssquery-prototype.html) 00:40:50 INFO - PROCESS | 2318 | RSS: Main: 347672576 00:40:50 INFO - PROCESS | 2318 | 00:43:54 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:51600/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51600/tests/dromaeo/cssquery-yui.html) 00:43:54 INFO - PROCESS | 2318 | RSS: Main: 325468160 00:43:54 INFO - PROCESS | 2318 | 00:46:58 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:51600/tests/dromaeo/cssquery-yui.html (next: http://localhost:51600/tests/dromaeo/cssquery-dojo.html) 00:46:58 INFO - PROCESS | 2318 | RSS: Main: 398462976 00:46:58 INFO - PROCESS | 2318 | 00:46:58 INFO - PROCESS | 2318 | __start_tp_report 00:46:58 INFO - PROCESS | 2318 | _x_x_mozilla_page_load 00:46:58 INFO - PROCESS | 2318 | _x_x_mozilla_page_load_details 00:46:58 INFO - PROCESS | 2318 | |i|pagename|runs| 00:46:58 INFO - PROCESS | 2318 | |0;dojo.html;3254.088855120567;3257.1531401835523;3269.133679574913;3271.9018429447124;3321.76747627666;5530.364008139055;5615.989121958051;5636.239107720462;5673.886522269558;5680.034394152994;5608.962341966729;5638.464345887144;5718.59969802114;5724.885502289952;5760.279965004374;5052.595792336604;5091.541761241488;5102.668326558762;5171;5179.067767801795;5219.00838840621;5241.842744717665;5258;5267.209918512215;5321.680699158043;5108.5402313791565;5214.973925130388;5221.216817477409;5250.789968401259;5325;5134.127198376248;5194.117000109953;5197.324347834758;5197.58419326453;5209.426963034063;5065.848024559269;5146.588272938194;5150.510701483353;5155.561777248939;5157.948420515784;5674.801381951653;5684.175794509773;5685.857853553653;5689.487946084872;5697.6866272355;6111.01444231774;6116.244470650255;6119.866903106265;6121.08717519695;6130.493792663006;6119.847003824895;6141.416565426277;6142.928535732134;6158.983767678328;6170.568060235785;5479.424660410599;5699.886002279931;5707.486326230659;5747.626404283708;5755.510781583571;6207.224096987877;6212.1303017577575;6224.688765561704;6231.781887633911;6236.844078898064;5926.555508336892;5963.165156878041;5981.102834574762;6073.605215660968;6090.817275481742;6100.914243738774;6155;6164.982777841696;6216.129741836146;6230.127782110508;6127.111568822495;6146.907796383058;6148.78479253224;6167.414095660905;6174.44430001302;6038.094285857069;6162.014077747539;6188.969055154786;6191.81424557264;6194.721237544321;4817.253325734517;4818.445878723992;4828.782704778293;4831.323614693875;4862.17343051682;4344.543822898613;4364.498082720528;4368.8907777305185;4386.188555117314;4401.867943961623;5707.286589176353;5715.571332150105;5719.370869204384;5719.971400143056;5725.112607545837;6038.486728628028;6113.719560719409;6121.7578389577775;6178.165947597017;6204.193454850841;4785.832495862698;5624.550035997192;5651.067573850269;5671.461211184931;5673.404292549306;5315.335583052119;5315.681059136464;5323.387810401776;5324.334458192726;5326.334208223972;6147.5245940972945;6200.751969921243;6210.285817131088;6216.595921265103;6219.284782250099;6154.661493617894;6213.5339849512375;6228.314885362516;6242.219722534684;6255.343188965093;6211.9068213975925;6222.844428889314;6225.31521532622;6239.844003899757;6246.656433896179;5982.282126144891;6030.065339872327;6144.078388241799;6149.508039356931;6171.783987560414;6125.540694081788;6136.825445958321;6164.013757798731;6166.136740856374;6226.750929962751;5887.882242355215;6039.305479869871;6042.130535921516;6075.1191077294425;6133.570650054453;6039.396060393926;6048.304444988707;6058.57589968698;6062.666553339609;6088.939110609014;4598.287265473857;5722.914156287742;5780.739866705924;5833.154192642128;5844.3571207168025;6024.457798798129;6024.638521688713;6025.638461692312;6034.064719968412;6036.034234522455;5747.626404283708;5783.132530120347;5841.737121829443;5844.736986835687;5853.590248682552 00:46:58 INFO - PROCESS | 2318 | |1;ext.html;465.93709849170375;488.7556221889055;492.79056401029555;516.2730665922489;521.9086659834528;28767;39479.605203947955;41226.175476490454;41404.792976035074;43265.56734432655;42509.14981700364;42951.35572966408;43052.138957220915;43076.92307692309;43101.56898431015;9349.018353072932;9512.809743805119;9524.095210954949;9533.285003624722;9547.283953703465;8383.203595658402;8616.00915894674;11293.20947533673;11531.36577488242;11567.305961642287;11402.372869492174;11447.198696091276;11478.139139564524;11479.59821406251;11483.885161148406;8392.03491598468;11329.376884271362;11390.658280251606;11399.259048161843;11404.258723183008;8316.293115085226;11089.338558745923;11372.203945723802;11401.657950261506;11491.253068550517;39997.60002399968;40395.59604403948;40398.39402408966;40459.595404045875;40590;3424.092615456906;3437.862485500577;3460.0138960396416;3522.735794815399;3918.3142949983926;30603.081907542808;30859;31154.688453115406;31816.840915795274;31863.681363186304;2999.7750168737434;3172.809631422122;3216.083416226364;3246.5454836322933;3327.683870032343;477784.9999999965;478474;483360;483884;483964;33437.99686009424;34160.829195854356;60078.39921600728;60676.08985865216;60687;34793.13017174591;34984.650153498646;35030.29939401198;35042.123946901535;35083;14105.506307279196;14193.645158871112;14227.35976881043;14235.074720143157;14235.28823558818;10855.565777368816;11104.056155226735;11952.103592230618;12060.396980150957;12067.336296503776;7273.381762550137;7450.85098298031;7671;7709.691612335556;7749.535027898344;3200.5519227308196;3205.4230238556815;3220.855061522237;3225.5161725741327;3235.2073741932904;899.3030401438806;920.8940971788196;973.7662960889477;1012.7873146639288;1078.7604713475957;29864.253393664898;29898.551521727193;30652;30823.537646935314;31239.84380078085;904.8371293167162;1038.0605551975475;1061.3366645846345;1086.940218287986;1090.4711215060688;14544.490942817163;15019.24903754808;15552.688946221013;15996.840031599535;16114.597135071717;645646;652005;652764;653003;653162;57775.13337299944;58399.70800146057;58404;58404.41595584075;58435;1214.3624597086423;1240.5720026590811;1378.6553361659585;1392.6379141423304;1408.5140626483847;27881.860590696917;29610.407791844475;29718;30386.84806575953;30399.240018999702;50990;51296;51339.71650708762;51389.48610513847;51398.743006286226;568528;571300.1434992799;571720;571921;572281.2771872395;25202.87398563069;25459.872700636377;25685.972561097347;25767.742322577284;25773.226803195936;47178.52821471879;47709.284360733924;47888.04223915572;48153.03693926172;48443.757781210865;33434.99695009154;37713;38140.23719525649;38868.80565597267;39407.014824629616;33394.83302583471;38238.80880595579;38567;38723.61276387313;39332.80063923361;37658.43512347262;37900.81049594734;38730.22539549137;38759.61240387673;38792.22415551617;32097.518537222426;32574;33377.332453351286;34437;34527.13682157966;22183.556328873008;22384.664230036236;25055.624165637164;25255.87372063128;25672.61491077598 00:46:58 INFO - PROCESS | 2318 | |2;jquery.html;346.05699468947137;362.15617610966467;366.66633363639085;372.8098669678463;393.07627076370534;15296.617584560378;15583.922080389597;16413.589660258498;20734.585308293827;21297;20745.170193192254;20792.89603551984;21386.46533836651;21411.892940535276;21561.784382156173;5829.591928564992;5916.964531207043;5955.88088238235;6099.81700548982;6116.327204007555;5896.469317761422;6101.816945491642;6112.81661550152;6118.11287363332;6125.295591007024;5667.121596152603;6049.758009679607;6053.909191362133;6060.999935010718;6065.211522502091;5794.536437085023;5964.343922168558;6005.459508644221;6049.425304596057;6056.999999999978;5867.735951882176;5877.118432235156;5881.47066763989;5884.264466941632;5890.087036509348;13304.334783260894;13392.86607133926;13489.662758431019;13646.727065458734;13647.249401282925;2198.681191227279;2297.5979203639295;2436.646686230504;2444.743301953305;2654.681438227425;9622.663206787798;9753.951230243874;9832;13872.4451021959;14856.777148342784;1823.9817601823945;1870;1881.6801143805585;1929.6237233739425;1929.6623090959167;97391.02608973891;118616;131390.6860931388;131854.3407282967;132728;10805.567777288978;11150.498227579616;11208.775824483464;11375.748667646552;11384.715382115513;14212.289385530683;14213;14240.928795355956;14262.57212283633;14380.209088500233;8002.479838810459;8116.310113640288;8119.269265766109;8128.674853005814;8429.241368276884;6776.42400395962;8252.752417427488;8348.540830254273;8515.276201522816;8569.657213711507;4078.3270760324212;4241.151769646083;4365.738055716667;4450.710703804242;4554.339620755039;1880.7272945422837;1915.2147619476227;1916.2335065973723;1916.8370688491354;1939.5539026024094;840.6469282901074;895.8443607745935;930.432436213909;959.2661613865398;1064.595453727594;20012.299569515;21850.12599496034;21856.78143218579;21991.780082198973;22087.889560552416;750.4709180028067;846.9915300846912;904.1230006893303;921.7557347302836;995.318207028188;10711.73292145903;11277.436128193558;11285.37930413835;11369.31784092957;11422.029127524087;556361;569889;573317;597075;597334;94611;122443.38432856239;129850.70149298386;138927;139622;930.4045410937006;935.050923312838;967.8548217767391;968.1818863060703;968.6270785747538;19207;19216.903915480332;19243.498345215034;19519.219231230592;19568.60862782765;42566.08452619577;53063;53377.398678039724;56021.159682603975;57345.13982290185;72803.90794137986;84192.3161536778;84305;86272.56863715641;86678;7730;8027.839443210986;8034.598270086355;8042.3968202383885;8049.51702897828;10367.27429079957;11627.767444651228;11806.409679516162;11890.643280701594;11965.76068478643;11254.099672026383;11350.262232954832;11582.36297003673;11599.362035088152;11624.244424112405;10091.545880435251;10389.272750907365;11007.394593297446;11368.715782105513;11600.30398176112;9138.360314777901;9478.431294122374;10938.124950003821;11167.664970050912;11322.886771132184;7660.5403675779635;7722.884156737541;7796.766097017098;8004.399670024655;8011.198880111942;9501.61993520279;10534.209934255116;10929.78140437171;10950.34297942126;11299.661010169708 00:46:58 INFO - PROCESS | 2318 | |3;mootools.html;1550.387596899225;1583.4537084705776;1814.9455516334506;1879.4737473507423;1969.497778066593;8323.292520135788;8735.912640873597;8747.431416957901;8751.518666473341;8752.168543988311;7667.654955527;7913.248241417056;7916.287534121928;7995.080565734927;8530.87203691945;1762.8501577365907;2116.47088227943;2125.914963401462;2235.5975924333693;2302.700648915639;2335.065973610561;2341.0869760793303;2344.6600242964846;2345.4019225097577;2348.729896061949;2266.841321107523;2296.5062511560013;2332.242021343062;2336.7429582745885;2338.1232037985756;2051.5589148333106;2133.1680644548637;2133.925312614059;2137.422895818136;2144.774798646151;2111.989440052805;2265.524239909621;2327.4297797039835;2334.8248881333966;2347.8473899196497;8587.828243435159;8635.39552231344;8669.523176225304;8736.563171841382;8765.737027889174;5169.147090730025;5324.840254792362;5331.786728530854;5346.705931173784;5362.4637536246455;3010.5634682970845;3608.314420260142;3639.47227651989;3644.3075815594952;3699.7595156314756;1014.3862962907408;1042.791441711653;1076.1122074288664;1085.4247248958065;1088.5754555723274;11233.831492527619;11272.985431311221;11288.774224515546;11297.830532542019;11331.32012079278;4340.696151269444;4598.8620341389815;4663.556962088596;4669.2996050592;4728.645351598644;9623.230141588656;9632.651428799974;9632.662856800118;9638.710838674851;9643.324967252365;4524.773761311922;5257.237700533401;5257.921131183035;5258.973705131526;5260.658057226345;4575.977120114445;4762.976185119052;4821.156297647897;4821.686590371614;4824.228123500293;3708.054446116223;3760.3113773651426;3779.281936432069;3810.733248672622;3858.2476417098956;1239.5661518468644;1249.0819247852821;1259.0745801835644;1266.5567051532075;1267.9556215532411;796.7092011415791;847.8417893347232;904.4708845325426;906.2659246010752;926.8645908761848;5620.718964051781;5644.209810626516;5651.576131790132;5657.886842263131;5985.820425387245;809.7611204694629;896.6996056321075;942.58997336159;955.9139677429065;959.8865316233137;3291.4240007998505;3439.518467414514;3482.9651703483146;3925.685945124383;3984.143409167043;10351.534180961875;10415.42715150674;10569.365838049742;10575.471226438647;10583.682489525327;10532.842007369896;10535.262531622713;10553.525091370906;10561.471926403803;10581.4709264538;7956.840863182704;8206.958965205255;8208.343332533383;8211.137830527947;8213.917860821435;4943.728094954812;5387.838364849061;5607;5799;5817.621854579439;9323.906760932576;9724.805503889742;9729.610815567297;9741.220702343653;9790.559424826042;9545.093216144454;9715.854262185932;9855.605775769176;9939.204863610748;9955.352902061342;6855.314468553105;7929;7937.166597507409;8124.8781268279845;8128.918710812816;7965.800854978672;8069.757907262557;8154.143814899588;8163.306118979954;8168;7250.709971601077;7274.672639731119;7311.707531698672;7345.926540734525;7371.705131794883;7216.170140433707;7219.386352159915;7223.494355395072;7246.492745507764;7247.601381923834;6700.793857105573;6733.528652994243;6880.105586273952;6882;6884.827879303058;3248.5289633003554;4224.619784219435;4433.869363312464;4908.607311415007;4933.679310844784;4867;4877.024595081069;4954.851354459372;5024.899502009866;5039.521245481674 00:46:58 INFO - PROCESS | 2318 | |4;prototype.html;298.7072668784591;303.8101186758276;308.5695454840497;316.2788841441513;318;4831.251156070814;5179.404368497624;5278.868028299295;5281.2342210379475;5350.759215835287;4359.803808828602;4872.611305777854;4902.391751753349;5100.954304367605;5111.105556527602;3130.5773720547663;3960.5643379228404;4024.436578878952;4029.9798501007454;4039.2527382434196;3503.9649603503894;3987.2224916141363;4005.3190957537145;4018.4976877890263;4063.3701776224584;3008.5487176923416;3793.279276937387;3878.6897048236074;3897.770918553373;3990.2418540477215;3239.838008099609;3357.5489892378578;3492.3189977954307;3974.1256923477076;4008.739431936944;3168.1287645897332;3302.6862448067636;3512.683858452726;3517.613062563116;3535.6641119093647;4262.531121576624;4670.8365207217585;5090.745462726849;5100.413452452978;5139.357580302462;3494.52823868777;4443.977780111111;4481.64146868253;4527.298268768346;4573.588377046049;4856.490068542823;5441;5542.334919809608;5559.833205003856;5594.825086731791;3790;3792;3792.6017768134225;3808.9619103808886;3810.8475660973527;5595.4964053235;5700.37295897451;5742.736597948445;5769.942300576982;5790.623609465371;3500.457429098494;3548.8757893473603;3808.419505905074;3809.4095415210686;3810.6951443884423;3829.885103446901;3855.7879316637855;3877.8254978526033;3883.485440678138;3883.572806991229;4044.69664775143;4137.882771651637;4154.31453810124;4483.663725220622;4562.361269422284;4896.653420309443;4916.852494425173;5416.350037995387;5435.211894275387;5580.776768929279;1306.2097431054265;1310.351376068852;1318.2090745552591;1321.4714114354335;1327.9468821247042;710.7974227345181;717.5730440387961;812.1837553259055;837.5803013891517;856.2935578148052;4036.495438070241;5121.667091639031;5138.229265610188;5138.58891288696;5182.222666600041;4551.362809206714;4953.467577166852;5531.170324451365;5584.888302234014;5633.774649013993;4112.876613701594;4736.715797052188;4954.20732682769;5289.862679523844;5326.36083669962;2853.7871404652938;2887.232162028531;2964.5325563846036;2985.835524145585;2988.3276262840686;5682.460166284196;5904.911426328608;5922.808560832434;5927.199828023248;5943.791967281124;4556.840510582114;5289.3917199521775;5496.587755918322;5508.788066625336;5866.325372582208;5222.817201397933;5239.659422137549;5786.537077033827;5803.593748437569;5894.292684877928;5210.775467764996;5295.7352132394;5605.551555875439;5683.89164112994;5721.685307307972;4614.561616646413;4675.906481870412;4970.304157417892;5209.4009188943755;5697.686627235542;5852.473277405054;5905.287466634628;5928.436798504135;5945.464908158287;5965.703204266475;3232.062701816447;3669.449582562637;3785.4668859112103;3801.3727734924532;3831.9616803831605;5686.886262274814;5717.742701578356;5740.856478588069;5748.425157484218;5766.682832444256;5586.581006424616;5589.55283577321;5611.551075913999;5612.418287587592;5651.943480565142;4691.780137164294;5253.816116435906;5355.3305836770405;5512.200730894078;5542;5197.610179236497;5377.704226267593;5417.8103766367985;5419.103313840124;5423.701696406735;4543.54564543543;5342.919856202082;5411.161270003156;5419.945800542102;5434.619576629756;4079.8376860264107;4563.452385713736;4581.496035436166;5384.434634363335;5457.345118585795 00:46:58 INFO - PROCESS | 2318 | |5;yui.html;711.8078118907895;732.2018999290772;770.7340967366257;782.7416952405703;820.4011071917496;15398.692026159484;15551.844481555181;15558.222088895553;15601.453949111783;15631.296591653374;14017.088889222194;14164;14165.92917035416;14171.503997360094;14186.645333866658;696.96166710831;726.61852527423;731.8828987362023;878.3324673248313;901.2339511415311;899.5771987166022;903.1194585279366;908.9818203635923;910.3672947301628;912.4479689787682;966.7728083900278;969.9127078562927;970.1705042188933;971.9319647624669;973.7030205787232;962.4658314635375;963.0465838819588;964.3538828984528;964.392432767352;965.0397854135146;544.6568661743116;556.3629644057572;576.5848589015902;705.0939542687622;714.3606472207397;14886.032407893452;14917.701645967129;14926.40294388223;14964.176970266632;14969.850301496954;13299.268540230283;13489.19064856102;13502;13546.729065418636;13644.317784110755;12114.273143611412;12369.196002259914;12493.375331233492;12516.3741812909;12713.93643031779;4309.719868208556;4340.761258130801;4569.9314510282375;4642.721436713808;4649.3026046093355;86590.56704716437;86709.56645216797;86823;86925.13074869233;87008.69486957701;10333.22500812442;10388.272820902615;10592.328936480024;10632.946835265775;10712.839307410395;20906.686399704016;20954.580908381748;20957.26649567258;21001.369958901258;21013.474663133544;7617.352525035323;7686.692532298645;7705.345045671069;7755.828368056953;7799.142094369615;4141.81361838718;4266.573342665709;4267.3812297217355;4310.4180935573295;4455.086707225011;3378.7803792753393;3489.755717099779;3490.3193877193703;3493.056874643832;3505.369033573981;547.258464780225;586.4077281945266;623.4700504571078;640.3500447046251;653.5033374635217;598.1715324275822;611.437477520682;630.7949916277229;633.1294470103608;636.296891934415;8493.405461617751;8712.825743485095;8815.515146666867;8871.379003469696;8972.68595599164;583.7956715149663;605.8592839754677;616.765629060954;627.2579300488322;650.5413683353224;4108.219438306712;4252.149570085995;4253.553376895444;4318.201132790444;4382.517923028464;116597;116957.8304216947;117434;118234;119174.40412798054;92305;96332.0366796337;105723.47138264413;106278;107886.46056769666;61573;70106.9483957741;90512;90924.99999999868;91830;8331.417030764136;8410.158984101541;8423.410361274651;8471.449355791854;8697.826043479221;56388.43611563832;57303.42696573148;57850.842983140945;60293.0956035651;60495.39504604898;65999;75553;82287.5885620568;84122;84689.57655211685;11309.321440713584;11332.263402878787;11479.139064570023;11815.940920295687;11966.940165299466;11762.94118529402;11976.101792365433;12071.155019148575;12085.939570302093;12516.561920332744;11529.82705259405;11644.592439264585;11721.589744358907;11767.352795596324;11886.28682279066;9662.275329350186;11252.156088293246;11573.444746521885;11809.586664467046;11892.762144756884;11367.943160284145;11402.087832973508;11426.428678565871;11433.828492572451;11798.941005294919;9485.857712134186;9634.470104144058;9797.118259356692;9933.403995760278;10033.799324013626;8049.637766300648;9319.720408387759;9746.36648617866;9807.607695692377;9814.55834487464 00:46:58 INFO - PROCESS | 2318 | __end_tp_report 00:46:58 INFO - PROCESS | 2318 | __start_cc_report 00:46:58 INFO - PROCESS | 2318 | _x_x_mozilla_cycle_collect,2425 00:46:58 INFO - PROCESS | 2318 | __end_cc_report 00:46:58 INFO - PROCESS | 2318 | __startTimestamp1477468018406__endTimestamp 00:46:58 INFO - PROCESS | 2318 | 00:46:58 INFO - PROCESS | 2318 | ------- Summary: start ------- 00:46:58 INFO - PROCESS | 2318 | Number of tests: 6 00:46:58 INFO - PROCESS | 2318 | 00:46:58 INFO - PROCESS | 2318 | [#0] dojo.html Cycles:165 Average:5670.23 Median:5844.36 stddev:639.99 (11.0%) stddev-sans-first:613.24 00:46:58 INFO - PROCESS | 2318 | Values: 3254.1 3257.2 3269.1 3271.9 3321.8 5530.4 5616.0 5636.2 5673.9 5680.0 5609.0 5638.5 5718.6 5724.9 5760.3 5052.6 5091.5 5102.7 5171.0 5179.1 5219.0 5241.8 5258.0 5267.2 5321.7 5108.5 5215.0 5221.2 5250.8 5325.0 5134.1 5194.1 5197.3 5197.6 5209.4 5065.8 5146.6 5150.5 5155.6 5157.9 5674.8 5684.2 5685.9 5689.5 5697.7 6111.0 6116.2 6119.9 6121.1 6130.5 6119.8 6141.4 6142.9 6159.0 6170.6 5479.4 5699.9 5707.5 5747.6 5755.5 6207.2 6212.1 6224.7 6231.8 6236.8 5926.6 5963.2 5981.1 6073.6 6090.8 6100.9 6155.0 6165.0 6216.1 6230.1 6127.1 6146.9 6148.8 6167.4 6174.4 6038.1 6162.0 6189.0 6191.8 6194.7 4817.3 4818.4 4828.8 4831.3 4862.2 4344.5 4364.5 4368.9 4386.2 4401.9 5707.3 5715.6 5719.4 5720.0 5725.1 6038.5 6113.7 6121.8 6178.2 6204.2 4785.8 5624.6 5651.1 5671.5 5673.4 5315.3 5315.7 5323.4 5324.3 5326.3 6147.5 6200.8 6210.3 6216.6 6219.3 6154.7 6213.5 6228.3 6242.2 6255.3 6211.9 6222.8 6225.3 6239.8 6246.7 5982.3 6030.1 6144.1 6149.5 6171.8 6125.5 6136.8 6164.0 6166.1 6226.8 5887.9 6039.3 6042.1 6075.1 6133.6 6039.4 6048.3 6058.6 6062.7 6088.9 4598.3 5722.9 5780.7 5833.2 5844.4 6024.5 6024.6 6025.6 6034.1 6036.0 5747.6 5783.1 5841.7 5844.7 5853.6 00:46:58 INFO - PROCESS | 2318 | 00:46:58 INFO - PROCESS | 2318 | [#1] ext.html Cycles:180 Average:68657.75 Median:34888.89 stddev:153220.61 (439.2%) stddev-sans-first:153564.89 00:46:58 INFO - PROCESS | 2318 | Values: 465.9 488.8 492.8 516.3 521.9 28767.0 39479.6 41226.2 41404.8 43265.6 42509.1 42951.4 43052.1 43076.9 43101.6 9349.0 9512.8 9524.1 9533.3 9547.3 8383.2 8616.0 11293.2 11531.4 11567.3 11402.4 11447.2 11478.1 11479.6 11483.9 8392.0 11329.4 11390.7 11399.3 11404.3 8316.3 11089.3 11372.2 11401.7 11491.3 39997.6 40395.6 40398.4 40459.6 40590.0 3424.1 3437.9 3460.0 3522.7 3918.3 30603.1 30859.0 31154.7 31816.8 31863.7 2999.8 3172.8 3216.1 3246.5 3327.7 477785.0 478474.0 483360.0 483884.0 483964.0 33438.0 34160.8 60078.4 60676.1 60687.0 34793.1 34984.7 35030.3 35042.1 35083.0 14105.5 14193.6 14227.4 14235.1 14235.3 10855.6 11104.1 11952.1 12060.4 12067.3 7273.4 7450.9 7671.0 7709.7 7749.5 3200.6 3205.4 3220.9 3225.5 3235.2 899.3 920.9 973.8 1012.8 1078.8 29864.3 29898.6 30652.0 30823.5 31239.8 904.8 1038.1 1061.3 1086.9 1090.5 14544.5 15019.2 15552.7 15996.8 16114.6 645646.0 652005.0 652764.0 653003.0 653162.0 57775.1 58399.7 58404.0 58404.4 58435.0 1214.4 1240.6 1378.7 1392.6 1408.5 27881.9 29610.4 29718.0 30386.8 30399.2 50990.0 51296.0 51339.7 51389.5 51398.7 568528.0 571300.1 571720.0 571921.0 572281.3 25202.9 25459.9 25686.0 25767.7 25773.2 47178.5 47709.3 47888.0 48153.0 48443.8 33435.0 37713.0 38140.2 38868.8 39407.0 33394.8 38238.8 38567.0 38723.6 39332.8 37658.4 37900.8 38730.2 38759.6 38792.2 32097.5 32574.0 33377.3 34437.0 34527.1 22183.6 22384.7 25055.6 25255.9 25672.6 00:46:58 INFO - PROCESS | 2318 | 00:46:58 INFO - PROCESS | 2318 | [#2] jquery.html Cycles:180 Average:34275.25 Median:369.74 stddev:97050.53 (26248.5%) stddev-sans-first:97289.34 00:46:58 INFO - PROCESS | 2318 | Values: 346.1 362.2 366.7 372.8 393.1 15296.6 15583.9 16413.6 20734.6 21297.0 20745.2 20792.9 21386.5 21411.9 21561.8 5829.6 5917.0 5955.9 6099.8 6116.3 5896.5 6101.8 6112.8 6118.1 6125.3 5667.1 6049.8 6053.9 6061.0 6065.2 5794.5 5964.3 6005.5 6049.4 6057.0 5867.7 5877.1 5881.5 5884.3 5890.1 13304.3 13392.9 13489.7 13646.7 13647.2 2198.7 2297.6 2436.6 2444.7 2654.7 9622.7 9754.0 9832.0 13872.4 14856.8 1824.0 1870.0 1881.7 1929.6 1929.7 97391.0 118616.0 131390.7 131854.3 132728.0 10805.6 11150.5 11208.8 11375.7 11384.7 14212.3 14213.0 14240.9 14262.6 14380.2 8002.5 8116.3 8119.3 8128.7 8429.2 6776.4 8252.8 8348.5 8515.3 8569.7 4078.3 4241.2 4365.7 4450.7 4554.3 1880.7 1915.2 1916.2 1916.8 1939.6 840.6 895.8 930.4 959.3 1064.6 20012.3 21850.1 21856.8 21991.8 22087.9 750.5 847.0 904.1 921.8 995.3 10711.7 11277.4 11285.4 11369.3 11422.0 556361.0 569889.0 573317.0 597075.0 597334.0 94611.0 122443.4 129850.7 138927.0 139622.0 930.4 935.1 967.9 968.2 968.6 19207.0 19216.9 19243.5 19519.2 19568.6 42566.1 53063.0 53377.4 56021.2 57345.1 72803.9 84192.3 84305.0 86272.6 86678.0 7730.0 8027.8 8034.6 8042.4 8049.5 10367.3 11627.8 11806.4 11890.6 11965.8 11254.1 11350.3 11582.4 11599.4 11624.2 10091.5 10389.3 11007.4 11368.7 11600.3 9138.4 9478.4 10938.1 11167.7 11322.9 7660.5 7722.9 7796.8 8004.4 8011.2 9501.6 10534.2 10929.8 10950.3 11299.7 00:46:58 INFO - PROCESS | 2318 | 00:46:58 INFO - PROCESS | 2318 | [#3] mootools.html Cycles:180 Average:5568.40 Median:5032.21 stddev:3138.63 (62.4%) stddev-sans-first:3132.91 00:46:58 INFO - PROCESS | 2318 | Values: 1550.4 1583.5 1814.9 1879.5 1969.5 8323.3 8735.9 8747.4 8751.5 8752.2 7667.7 7913.2 7916.3 7995.1 8530.9 1762.9 2116.5 2125.9 2235.6 2302.7 2335.1 2341.1 2344.7 2345.4 2348.7 2266.8 2296.5 2332.2 2336.7 2338.1 2051.6 2133.2 2133.9 2137.4 2144.8 2112.0 2265.5 2327.4 2334.8 2347.8 8587.8 8635.4 8669.5 8736.6 8765.7 5169.1 5324.8 5331.8 5346.7 5362.5 3010.6 3608.3 3639.5 3644.3 3699.8 1014.4 1042.8 1076.1 1085.4 1088.6 11233.8 11273.0 11288.8 11297.8 11331.3 4340.7 4598.9 4663.6 4669.3 4728.6 9623.2 9632.7 9632.7 9638.7 9643.3 4524.8 5257.2 5257.9 5259.0 5260.7 4576.0 4763.0 4821.2 4821.7 4824.2 3708.1 3760.3 3779.3 3810.7 3858.2 1239.6 1249.1 1259.1 1266.6 1268.0 796.7 847.8 904.5 906.3 926.9 5620.7 5644.2 5651.6 5657.9 5985.8 809.8 896.7 942.6 955.9 959.9 3291.4 3439.5 3483.0 3925.7 3984.1 10351.5 10415.4 10569.4 10575.5 10583.7 10532.8 10535.3 10553.5 10561.5 10581.5 7956.8 8207.0 8208.3 8211.1 8213.9 4943.7 5387.8 5607.0 5799.0 5817.6 9323.9 9724.8 9729.6 9741.2 9790.6 9545.1 9715.9 9855.6 9939.2 9955.4 6855.3 7929.0 7937.2 8124.9 8128.9 7965.8 8069.8 8154.1 8163.3 8168.0 7250.7 7274.7 7311.7 7345.9 7371.7 7216.2 7219.4 7223.5 7246.5 7247.6 6700.8 6733.5 6880.1 6882.0 6884.8 3248.5 4224.6 4433.9 4908.6 4933.7 4867.0 4877.0 4954.9 5024.9 5039.5 00:46:58 INFO - PROCESS | 2318 | 00:46:58 INFO - PROCESS | 2318 | [#4] prototype.html Cycles:180 Average:4418.48 Median:4935.16 stddev:1381.82 (28.0%) stddev-sans-first:1350.66 00:46:58 INFO - PROCESS | 2318 | Values: 298.7 303.8 308.6 316.3 318.0 4831.3 5179.4 5278.9 5281.2 5350.8 4359.8 4872.6 4902.4 5101.0 5111.1 3130.6 3960.6 4024.4 4030.0 4039.3 3504.0 3987.2 4005.3 4018.5 4063.4 3008.5 3793.3 3878.7 3897.8 3990.2 3239.8 3357.5 3492.3 3974.1 4008.7 3168.1 3302.7 3512.7 3517.6 3535.7 4262.5 4670.8 5090.7 5100.4 5139.4 3494.5 4444.0 4481.6 4527.3 4573.6 4856.5 5441.0 5542.3 5559.8 5594.8 3790.0 3792.0 3792.6 3809.0 3810.8 5595.5 5700.4 5742.7 5769.9 5790.6 3500.5 3548.9 3808.4 3809.4 3810.7 3829.9 3855.8 3877.8 3883.5 3883.6 4044.7 4137.9 4154.3 4483.7 4562.4 4896.7 4916.9 5416.4 5435.2 5580.8 1306.2 1310.4 1318.2 1321.5 1327.9 710.8 717.6 812.2 837.6 856.3 4036.5 5121.7 5138.2 5138.6 5182.2 4551.4 4953.5 5531.2 5584.9 5633.8 4112.9 4736.7 4954.2 5289.9 5326.4 2853.8 2887.2 2964.5 2985.8 2988.3 5682.5 5904.9 5922.8 5927.2 5943.8 4556.8 5289.4 5496.6 5508.8 5866.3 5222.8 5239.7 5786.5 5803.6 5894.3 5210.8 5295.7 5605.6 5683.9 5721.7 4614.6 4675.9 4970.3 5209.4 5697.7 5852.5 5905.3 5928.4 5945.5 5965.7 3232.1 3669.4 3785.5 3801.4 3832.0 5686.9 5717.7 5740.9 5748.4 5766.7 5586.6 5589.6 5611.6 5612.4 5651.9 4691.8 5253.8 5355.3 5512.2 5542.0 5197.6 5377.7 5417.8 5419.1 5423.7 4543.5 5342.9 5411.2 5419.9 5434.6 4079.8 4563.5 4581.5 5384.4 5457.3 00:46:58 INFO - PROCESS | 2318 | 00:46:58 INFO - PROCESS | 2318 | [#5] yui.html Cycles:180 Average:20883.33 Median:28472.40 stddev:31321.01 (110.0%) stddev-sans-first:31372.25 00:46:58 INFO - PROCESS | 2318 | Values: 711.8 732.2 770.7 782.7 820.4 15398.7 15551.8 15558.2 15601.5 15631.3 14017.1 14164.0 14165.9 14171.5 14186.6 697.0 726.6 731.9 878.3 901.2 899.6 903.1 909.0 910.4 912.4 966.8 969.9 970.2 971.9 973.7 962.5 963.0 964.4 964.4 965.0 544.7 556.4 576.6 705.1 714.4 14886.0 14917.7 14926.4 14964.2 14969.9 13299.3 13489.2 13502.0 13546.7 13644.3 12114.3 12369.2 12493.4 12516.4 12713.9 4309.7 4340.8 4569.9 4642.7 4649.3 86590.6 86709.6 86823.0 86925.1 87008.7 10333.2 10388.3 10592.3 10632.9 10712.8 20906.7 20954.6 20957.3 21001.4 21013.5 7617.4 7686.7 7705.3 7755.8 7799.1 4141.8 4266.6 4267.4 4310.4 4455.1 3378.8 3489.8 3490.3 3493.1 3505.4 547.3 586.4 623.5 640.4 653.5 598.2 611.4 630.8 633.1 636.3 8493.4 8712.8 8815.5 8871.4 8972.7 583.8 605.9 616.8 627.3 650.5 4108.2 4252.1 4253.6 4318.2 4382.5 116597.0 116957.8 117434.0 118234.0 119174.4 92305.0 96332.0 105723.5 106278.0 107886.5 61573.0 70106.9 90512.0 90925.0 91830.0 8331.4 8410.2 8423.4 8471.4 8697.8 56388.4 57303.4 57850.8 60293.1 60495.4 65999.0 75553.0 82287.6 84122.0 84689.6 11309.3 11332.3 11479.1 11815.9 11966.9 11762.9 11976.1 12071.2 12085.9 12516.6 11529.8 11644.6 11721.6 11767.4 11886.3 9662.3 11252.2 11573.4 11809.6 11892.8 11367.9 11402.1 11426.4 11433.8 11798.9 9485.9 9634.5 9797.1 9933.4 10033.8 8049.6 9319.7 9746.4 9807.6 9814.6 00:46:58 INFO - PROCESS | 2318 | -------- Summary: end -------- 00:46:58 INFO - PROCESS | 2318 | 00:46:59 INFO - TEST-INFO | 2318: exit 0 00:46:59 INFO - TEST-OK | dromaeo_css | took 1118766ms 00:46:59 INFO - TEST-START | kraken 00:46:59 INFO - operating with platform_type : mac_ 00:46:59 INFO - Initialising browser for kraken test... 00:46:59 INFO - TEST-INFO | started process 2323 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmpaf7tua/profile http://localhost:51600/getInfo.html) 00:47:01 INFO - PROCESS | 2323 | __metrics Screen width/height:1600/1200 00:47:01 INFO - PROCESS | 2323 | colorDepth:24 00:47:01 INFO - PROCESS | 2323 | Browser inner width/height: 1024/689 00:47:01 INFO - PROCESS | 2323 | __metrics 00:47:01 INFO - PROCESS | 2323 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:47:01 INFO - PROCESS | 2323 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:47:02 INFO - TEST-INFO | 2323: exit 0 00:47:02 INFO - Browser initialized. 00:47:02 INFO - Running cycle 1/1 for kraken test... 00:47:02 INFO - TEST-INFO | started process 2324 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmpaf7tua/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:47:14 INFO - PROCESS | 2324 | RSS: Main: 231251968 00:47:14 INFO - PROCESS | 2324 | 00:47:16 INFO - PROCESS | 2324 | Cycle 1(1): loaded http://localhost:51600/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51600/tests/kraken/driver.html?testName=audio-beat-detection) 00:47:17 INFO - PROCESS | 2324 | RSS: Main: 289976320 00:47:17 INFO - PROCESS | 2324 | 00:47:20 INFO - PROCESS | 2324 | Cycle 1(1): loaded http://localhost:51600/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51600/tests/kraken/driver.html?testName=audio-dft) 00:47:21 INFO - PROCESS | 2324 | RSS: Main: 291549184 00:47:21 INFO - PROCESS | 2324 | 00:47:24 INFO - PROCESS | 2324 | Cycle 1(1): loaded http://localhost:51600/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51600/tests/kraken/driver.html?testName=audio-fft) 00:47:25 INFO - PROCESS | 2324 | RSS: Main: 382152704 00:47:25 INFO - PROCESS | 2324 | 00:47:27 INFO - PROCESS | 2324 | Cycle 1(1): loaded http://localhost:51600/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51600/tests/kraken/driver.html?testName=audio-oscillator) 00:47:27 INFO - PROCESS | 2324 | RSS: Main: 284938240 00:47:27 INFO - PROCESS | 2324 | 00:47:29 INFO - PROCESS | 2324 | Cycle 1(1): loaded http://localhost:51600/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51600/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:47:30 INFO - PROCESS | 2324 | RSS: Main: 289415168 00:47:30 INFO - PROCESS | 2324 | 00:47:33 INFO - PROCESS | 2324 | Cycle 1(1): loaded http://localhost:51600/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51600/tests/kraken/driver.html?testName=imaging-darkroom) 00:47:33 INFO - PROCESS | 2324 | RSS: Main: 326770688 00:47:33 INFO - PROCESS | 2324 | 00:47:36 INFO - PROCESS | 2324 | Cycle 1(1): loaded http://localhost:51600/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51600/tests/kraken/driver.html?testName=imaging-desaturate) 00:47:37 INFO - PROCESS | 2324 | RSS: Main: 328429568 00:47:37 INFO - PROCESS | 2324 | 00:47:40 INFO - PROCESS | 2324 | Cycle 1(1): loaded http://localhost:51600/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51600/tests/kraken/driver.html?testName=json-parse-financial) 00:47:40 INFO - PROCESS | 2324 | RSS: Main: 326197248 00:47:40 INFO - PROCESS | 2324 | 00:47:42 INFO - PROCESS | 2324 | Cycle 1(1): loaded http://localhost:51600/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51600/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:47:43 INFO - PROCESS | 2324 | RSS: Main: 302661632 00:47:43 INFO - PROCESS | 2324 | 00:47:44 INFO - PROCESS | 2324 | Cycle 1(1): loaded http://localhost:51600/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51600/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:47:45 INFO - PROCESS | 2324 | RSS: Main: 304545792 00:47:45 INFO - PROCESS | 2324 | 00:47:47 INFO - PROCESS | 2324 | Cycle 1(1): loaded http://localhost:51600/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51600/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:47:48 INFO - PROCESS | 2324 | RSS: Main: 307396608 00:47:48 INFO - PROCESS | 2324 | 00:47:51 INFO - PROCESS | 2324 | Cycle 1(1): loaded http://localhost:51600/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51600/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:47:52 INFO - PROCESS | 2324 | RSS: Main: 319569920 00:47:52 INFO - PROCESS | 2324 | 00:47:54 INFO - PROCESS | 2324 | Cycle 1(1): loaded http://localhost:51600/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51600/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:47:55 INFO - PROCESS | 2324 | RSS: Main: 318664704 00:47:55 INFO - PROCESS | 2324 | 00:47:57 INFO - PROCESS | 2324 | Cycle 1(1): loaded http://localhost:51600/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51600/tests/kraken/driver.html?testName=ai-astar) 00:47:57 INFO - PROCESS | 2324 | RSS: Main: 363016192 00:47:57 INFO - PROCESS | 2324 | 00:47:57 INFO - PROCESS | 2324 | __start_tp_report 00:47:57 INFO - PROCESS | 2324 | _x_x_mozilla_page_load 00:47:57 INFO - PROCESS | 2324 | _x_x_mozilla_page_load_details 00:47:57 INFO - PROCESS | 2324 | |i|pagename|runs| 00:47:57 INFO - PROCESS | 2324 | |0;ai-astar;102;114;115;114;116;115;114;114;113;112 00:47:57 INFO - PROCESS | 2324 | |1;audio-beat-detection;154;113;112;148;112;121;114;112;145;113 00:47:57 INFO - PROCESS | 2324 | |2;audio-dft;183;183;183;184;187;185;179;184;181;183 00:47:57 INFO - PROCESS | 2324 | |3;audio-fft;81;60;59;86;61;60;58;58;82;57 00:47:57 INFO - PROCESS | 2324 | |4;audio-oscillator;87;71;88;70;67;68;119;96;96;115 00:47:57 INFO - PROCESS | 2324 | |5;imaging-gaussian-blur;88;85;87;85;87;85;88;84;88;83 00:47:57 INFO - PROCESS | 2324 | |6;imaging-darkroom;152;159;97;98;96;96;95;95;98;96 00:47:57 INFO - PROCESS | 2324 | |7;imaging-desaturate;81;85;82;82;95;131;127;86;81;81 00:47:57 INFO - PROCESS | 2324 | |8;json-parse-financial;56;55;54;53;53;55;53;54;53;55 00:47:57 INFO - PROCESS | 2324 | |9;json-stringify-tinderbox;72;67;70;79;73;70;70;72;71;70 00:47:57 INFO - PROCESS | 2324 | |10;stanford-crypto-aes;87;86;87;87;90;89;89;85;87;88 00:47:57 INFO - PROCESS | 2324 | |11;stanford-crypto-ccm;148;145;143;131;151;143;153;155;204;147 00:47:57 INFO - PROCESS | 2324 | |12;stanford-crypto-pbkdf2;172;172;171;172;173;171;169;171;171;172 00:47:57 INFO - PROCESS | 2324 | |13;stanford-crypto-sha256-iterative;70;69;68;68;69;69;69;68;68;67 00:47:57 INFO - PROCESS | 2324 | __end_tp_report 00:47:57 INFO - PROCESS | 2324 | __start_cc_report 00:47:57 INFO - PROCESS | 2324 | _x_x_mozilla_cycle_collect,1991 00:47:57 INFO - PROCESS | 2324 | __end_cc_report 00:47:57 INFO - PROCESS | 2324 | __startTimestamp1477468077598__endTimestamp 00:47:57 INFO - PROCESS | 2324 | 00:47:57 INFO - PROCESS | 2324 | ------- Summary: start ------- 00:47:57 INFO - PROCESS | 2324 | Number of tests: 14 00:47:57 INFO - PROCESS | 2324 | 00:47:57 INFO - PROCESS | 2324 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:3.98 (3.5%) stddev-sans-first:1.17 00:47:57 INFO - PROCESS | 2324 | Values: 102.0 114.0 115.0 114.0 116.0 115.0 114.0 114.0 113.0 112.0 00:47:57 INFO - PROCESS | 2324 | 00:47:57 INFO - PROCESS | 2324 | [#1] audio-beat-detection Cycles:10 Average:124.40 Median:117.50 stddev:17.32 (14.7%) stddev-sans-first:14.68 00:47:57 INFO - PROCESS | 2324 | Values: 154.0 113.0 112.0 148.0 112.0 121.0 114.0 112.0 145.0 113.0 00:47:57 INFO - PROCESS | 2324 | 00:47:57 INFO - PROCESS | 2324 | [#2] audio-dft Cycles:10 Average:183.20 Median:183.50 stddev:2.15 (1.2%) stddev-sans-first:2.28 00:47:57 INFO - PROCESS | 2324 | Values: 183.0 183.0 183.0 184.0 187.0 185.0 179.0 184.0 181.0 183.0 00:47:57 INFO - PROCESS | 2324 | 00:47:57 INFO - PROCESS | 2324 | [#3] audio-fft Cycles:10 Average:66.20 Median:60.50 stddev:11.72 (19.4%) stddev-sans-first:11.14 00:47:57 INFO - PROCESS | 2324 | Values: 81.0 60.0 59.0 86.0 61.0 60.0 58.0 58.0 82.0 57.0 00:47:57 INFO - PROCESS | 2324 | 00:47:57 INFO - PROCESS | 2324 | [#4] audio-oscillator Cycles:10 Average:87.70 Median:79.00 stddev:19.07 (24.1%) stddev-sans-first:20.22 00:47:57 INFO - PROCESS | 2324 | Values: 87.0 71.0 88.0 70.0 67.0 68.0 119.0 96.0 96.0 115.0 00:47:57 INFO - PROCESS | 2324 | 00:47:57 INFO - PROCESS | 2324 | [#5] imaging-gaussian-blur Cycles:10 Average:86.00 Median:87.00 stddev:1.83 (2.1%) stddev-sans-first:1.79 00:47:57 INFO - PROCESS | 2324 | Values: 88.0 85.0 87.0 85.0 87.0 85.0 88.0 84.0 88.0 83.0 00:47:57 INFO - PROCESS | 2324 | 00:47:57 INFO - PROCESS | 2324 | [#6] imaging-darkroom Cycles:10 Average:108.20 Median:96.00 stddev:25.01 (26.0%) stddev-sans-first:20.90 00:47:57 INFO - PROCESS | 2324 | Values: 152.0 159.0 97.0 98.0 96.0 96.0 95.0 95.0 98.0 96.0 00:47:57 INFO - PROCESS | 2324 | 00:47:57 INFO - PROCESS | 2324 | [#7] imaging-desaturate Cycles:10 Average:93.10 Median:82.00 stddev:19.41 (23.7%) stddev-sans-first:20.09 00:47:57 INFO - PROCESS | 2324 | Values: 81.0 85.0 82.0 82.0 95.0 131.0 127.0 86.0 81.0 81.0 00:47:57 INFO - PROCESS | 2324 | 00:47:57 INFO - PROCESS | 2324 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.50 stddev:1.10 (2.0%) stddev-sans-first:0.93 00:47:57 INFO - PROCESS | 2324 | Values: 56.0 55.0 54.0 53.0 53.0 55.0 53.0 54.0 53.0 55.0 00:47:57 INFO - PROCESS | 2324 | 00:47:57 INFO - PROCESS | 2324 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:71.50 stddev:3.13 (4.4%) stddev-sans-first:3.32 00:47:57 INFO - PROCESS | 2324 | Values: 72.0 67.0 70.0 79.0 73.0 70.0 70.0 72.0 71.0 70.0 00:47:57 INFO - PROCESS | 2324 | 00:47:57 INFO - PROCESS | 2324 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:87.50 stddev:1.51 (1.7%) stddev-sans-first:1.59 00:47:57 INFO - PROCESS | 2324 | Values: 87.0 86.0 87.0 87.0 90.0 89.0 89.0 85.0 87.0 88.0 00:47:57 INFO - PROCESS | 2324 | 00:47:57 INFO - PROCESS | 2324 | [#11] stanford-crypto-ccm Cycles:10 Average:152.00 Median:149.50 stddev:19.46 (13.0%) stddev-sans-first:20.59 00:47:57 INFO - PROCESS | 2324 | Values: 148.0 145.0 143.0 131.0 151.0 143.0 153.0 155.0 204.0 147.0 00:47:57 INFO - PROCESS | 2324 | 00:47:57 INFO - PROCESS | 2324 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:172.00 stddev:1.07 (0.6%) stddev-sans-first:1.12 00:47:57 INFO - PROCESS | 2324 | Values: 172.0 172.0 171.0 172.0 173.0 171.0 169.0 171.0 171.0 172.0 00:47:57 INFO - PROCESS | 2324 | 00:47:57 INFO - PROCESS | 2324 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:0.85 (1.2%) stddev-sans-first:0.71 00:47:57 INFO - PROCESS | 2324 | Values: 70.0 69.0 68.0 68.0 69.0 69.0 69.0 68.0 68.0 67.0 00:47:57 INFO - PROCESS | 2324 | -------- Summary: end -------- 00:47:57 INFO - PROCESS | 2324 | 00:47:58 INFO - TEST-INFO | 2324: exit 0 00:47:58 INFO - TEST-OK | kraken | took 59393ms 00:47:58 INFO - SUITE-END | took 1178s 00:47:58 INFO - Completed test suite (00:19:38) 00:47:58 INFO - javascript benchmark 00:47:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3254.088855120567, 3257.1531401835523, 3269.133679574913, 3271.9018429447124, 3321.76747627666, 5530.364008139055, 5615.989121958051, 5636.239107720462, 5673.886522269558, 5680.034394152994, 5608.962341966729, 5638.464345887144, 5718.59969802114, 5724.885502289952, 5760.279965004374, 5052.595792336604, 5091.541761241488, 5102.668326558762, 5171.0, 5179.067767801795, 5219.00838840621, 5241.842744717665, 5258.0, 5267.209918512215, 5321.680699158043, 5108.5402313791565, 5214.973925130388, 5221.216817477409, 5250.789968401259, 5325.0, 5134.127198376248, 5194.117000109953, 5197.324347834758, 5197.58419326453, 5209.426963034063, 5065.848024559269, 5146.588272938194, 5150.510701483353, 5155.561777248939, 5157.948420515784, 5674.801381951653, 5684.175794509773, 5685.857853553653, 5689.487946084872, 5697.6866272355, 6111.01444231774, 6116.244470650255, 6119.866903106265, 6121.08717519695, 6130.493792663006, 6119.847003824895, 6141.416565426277, 6142.928535732134, 6158.983767678328, 6170.568060235785, 5479.424660410599, 5699.886002279931, 5707.486326230659, 5747.626404283708, 5755.510781583571, 6207.224096987877, 6212.1303017577575, 6224.688765561704, 6231.781887633911, 6236.844078898064, 5926.555508336892, 5963.165156878041, 5981.102834574762, 6073.605215660968, 6090.817275481742, 6100.914243738774, 6155.0, 6164.982777841696, 6216.129741836146, 6230.127782110508, 6127.111568822495, 6146.907796383058, 6148.78479253224, 6167.414095660905, 6174.44430001302, 6038.094285857069, 6162.014077747539, 6188.969055154786, 6191.81424557264, 6194.721237544321, 4817.253325734517, 4818.445878723992, 4828.782704778293, 4831.323614693875, 4862.17343051682, 4344.543822898613, 4364.498082720528, 4368.8907777305185, 4386.188555117314, 4401.867943961623, 5707.286589176353, 5715.571332150105, 5719.370869204384, 5719.971400143056, 5725.112607545837, 6038.486728628028, 6113.719560719409, 6121.7578389577775, 6178.165947597017, 6204.193454850841, 4785.832495862698, 5624.550035997192, 5651.067573850269, 5671.461211184931, 5673.404292549306, 5315.335583052119, 5315.681059136464, 5323.387810401776, 5324.334458192726, 5326.334208223972, 6147.5245940972945, 6200.751969921243, 6210.285817131088, 6216.595921265103, 6219.284782250099, 6154.661493617894, 6213.5339849512375, 6228.314885362516, 6242.219722534684, 6255.343188965093, 6211.9068213975925, 6222.844428889314, 6225.31521532622, 6239.844003899757, 6246.656433896179, 5982.282126144891, 6030.065339872327, 6144.078388241799, 6149.508039356931, 6171.783987560414, 6125.540694081788, 6136.825445958321, 6164.013757798731, 6166.136740856374, 6226.750929962751, 5887.882242355215, 6039.305479869871, 6042.130535921516, 6075.1191077294425, 6133.570650054453, 6039.396060393926, 6048.304444988707, 6058.57589968698, 6062.666553339609, 6088.939110609014, 4598.287265473857, 5722.914156287742, 5780.739866705924, 5833.154192642128, 5844.3571207168025, 6024.457798798129, 6024.638521688713, 6025.638461692312, 6034.064719968412, 6036.034234522455, 5747.626404283708, 5783.132530120347, 5841.737121829443, 5844.736986835687, 5853.590248682552], "value": 5628.437463009998, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [465.93709849170375, 488.7556221889055, 492.79056401029555, 516.2730665922489, 521.9086659834528, 28767.0, 39479.605203947955, 41226.175476490454, 41404.792976035074, 43265.56734432655, 42509.14981700364, 42951.35572966408, 43052.138957220915, 43076.92307692309, 43101.56898431015, 9349.018353072932, 9512.809743805119, 9524.095210954949, 9533.285003624722, 9547.283953703465, 8383.203595658402, 8616.00915894674, 11293.20947533673, 11531.36577488242, 11567.305961642287, 11402.372869492174, 11447.198696091276, 11478.139139564524, 11479.59821406251, 11483.885161148406, 8392.03491598468, 11329.376884271362, 11390.658280251606, 11399.259048161843, 11404.258723183008, 8316.293115085226, 11089.338558745923, 11372.203945723802, 11401.657950261506, 11491.253068550517, 39997.60002399968, 40395.59604403948, 40398.39402408966, 40459.595404045875, 40590.0, 3424.092615456906, 3437.862485500577, 3460.0138960396416, 3522.735794815399, 3918.3142949983926, 30603.081907542808, 30859.0, 31154.688453115406, 31816.840915795274, 31863.681363186304, 2999.7750168737434, 3172.809631422122, 3216.083416226364, 3246.5454836322933, 3327.683870032343, 477784.9999999965, 478474.0, 483360.0, 483884.0, 483964.0, 33437.99686009424, 34160.829195854356, 60078.39921600728, 60676.08985865216, 60687.0, 34793.13017174591, 34984.650153498646, 35030.29939401198, 35042.123946901535, 35083.0, 14105.506307279196, 14193.645158871112, 14227.35976881043, 14235.074720143157, 14235.28823558818, 10855.565777368816, 11104.056155226735, 11952.103592230618, 12060.396980150957, 12067.336296503776, 7273.381762550137, 7450.85098298031, 7671.0, 7709.691612335556, 7749.535027898344, 3200.5519227308196, 3205.4230238556815, 3220.855061522237, 3225.5161725741327, 3235.2073741932904, 899.3030401438806, 920.8940971788196, 973.7662960889477, 1012.7873146639288, 1078.7604713475957, 29864.253393664898, 29898.551521727193, 30652.0, 30823.537646935314, 31239.84380078085, 904.8371293167162, 1038.0605551975475, 1061.3366645846345, 1086.940218287986, 1090.4711215060688, 14544.490942817163, 15019.24903754808, 15552.688946221013, 15996.840031599535, 16114.597135071717, 645646.0, 652005.0, 652764.0, 653003.0, 653162.0, 57775.13337299944, 58399.70800146057, 58404.0, 58404.41595584075, 58435.0, 1214.3624597086423, 1240.5720026590811, 1378.6553361659585, 1392.6379141423304, 1408.5140626483847, 27881.860590696917, 29610.407791844475, 29718.0, 30386.84806575953, 30399.240018999702, 50990.0, 51296.0, 51339.71650708762, 51389.48610513847, 51398.743006286226, 568528.0, 571300.1434992799, 571720.0, 571921.0, 572281.2771872395, 25202.87398563069, 25459.872700636377, 25685.972561097347, 25767.742322577284, 25773.226803195936, 47178.52821471879, 47709.284360733924, 47888.04223915572, 48153.03693926172, 48443.757781210865, 33434.99695009154, 37713.0, 38140.23719525649, 38868.80565597267, 39407.014824629616, 33394.83302583471, 38238.80880595579, 38567.0, 38723.61276387313, 39332.80063923361, 37658.43512347262, 37900.81049594734, 38730.22539549137, 38759.61240387673, 38792.22415551617, 32097.518537222426, 32574.0, 33377.332453351286, 34437.0, 34527.13682157966, 22183.556328873008, 22384.664230036236, 25055.624165637164, 25255.87372063128, 25672.61491077598], "value": 18671.407010147428, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.05699468947137, 362.15617610966467, 366.66633363639085, 372.8098669678463, 393.07627076370534, 15296.617584560378, 15583.922080389597, 16413.589660258498, 20734.585308293827, 21297.0, 20745.170193192254, 20792.89603551984, 21386.46533836651, 21411.892940535276, 21561.784382156173, 5829.591928564992, 5916.964531207043, 5955.88088238235, 6099.81700548982, 6116.327204007555, 5896.469317761422, 6101.816945491642, 6112.81661550152, 6118.11287363332, 6125.295591007024, 5667.121596152603, 6049.758009679607, 6053.909191362133, 6060.999935010718, 6065.211522502091, 5794.536437085023, 5964.343922168558, 6005.459508644221, 6049.425304596057, 6056.999999999978, 5867.735951882176, 5877.118432235156, 5881.47066763989, 5884.264466941632, 5890.087036509348, 13304.334783260894, 13392.86607133926, 13489.662758431019, 13646.727065458734, 13647.249401282925, 2198.681191227279, 2297.5979203639295, 2436.646686230504, 2444.743301953305, 2654.681438227425, 9622.663206787798, 9753.951230243874, 9832.0, 13872.4451021959, 14856.777148342784, 1823.9817601823945, 1870.0, 1881.6801143805585, 1929.6237233739425, 1929.6623090959167, 97391.02608973891, 118616.0, 131390.6860931388, 131854.3407282967, 132728.0, 10805.567777288978, 11150.498227579616, 11208.775824483464, 11375.748667646552, 11384.715382115513, 14212.289385530683, 14213.0, 14240.928795355956, 14262.57212283633, 14380.209088500233, 8002.479838810459, 8116.310113640288, 8119.269265766109, 8128.674853005814, 8429.241368276884, 6776.42400395962, 8252.752417427488, 8348.540830254273, 8515.276201522816, 8569.657213711507, 4078.3270760324212, 4241.151769646083, 4365.738055716667, 4450.710703804242, 4554.339620755039, 1880.7272945422837, 1915.2147619476227, 1916.2335065973723, 1916.8370688491354, 1939.5539026024094, 840.6469282901074, 895.8443607745935, 930.432436213909, 959.2661613865398, 1064.595453727594, 20012.299569515, 21850.12599496034, 21856.78143218579, 21991.780082198973, 22087.889560552416, 750.4709180028067, 846.9915300846912, 904.1230006893303, 921.7557347302836, 995.318207028188, 10711.73292145903, 11277.436128193558, 11285.37930413835, 11369.31784092957, 11422.029127524087, 556361.0, 569889.0, 573317.0, 597075.0, 597334.0, 94611.0, 122443.38432856239, 129850.70149298386, 138927.0, 139622.0, 930.4045410937006, 935.050923312838, 967.8548217767391, 968.1818863060703, 968.6270785747538, 19207.0, 19216.903915480332, 19243.498345215034, 19519.219231230592, 19568.60862782765, 42566.08452619577, 53063.0, 53377.398678039724, 56021.159682603975, 57345.13982290185, 72803.90794137986, 84192.3161536778, 84305.0, 86272.56863715641, 86678.0, 7730.0, 8027.839443210986, 8034.598270086355, 8042.3968202383885, 8049.51702897828, 10367.27429079957, 11627.767444651228, 11806.409679516162, 11890.643280701594, 11965.76068478643, 11254.099672026383, 11350.262232954832, 11582.36297003673, 11599.362035088152, 11624.244424112405, 10091.545880435251, 10389.272750907365, 11007.394593297446, 11368.715782105513, 11600.30398176112, 9138.360314777901, 9478.431294122374, 10938.124950003821, 11167.664970050912, 11322.886771132184, 7660.5403675779635, 7722.884156737541, 7796.766097017098, 8004.399670024655, 8011.198880111942, 9501.61993520279, 10534.209934255116, 10929.78140437171, 10950.34297942126, 11299.661010169708], "value": 9365.945711186543, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1550.387596899225, 1583.4537084705776, 1814.9455516334506, 1879.4737473507423, 1969.497778066593, 8323.292520135788, 8735.912640873597, 8747.431416957901, 8751.518666473341, 8752.168543988311, 7667.654955527, 7913.248241417056, 7916.287534121928, 7995.080565734927, 8530.87203691945, 1762.8501577365907, 2116.47088227943, 2125.914963401462, 2235.5975924333693, 2302.700648915639, 2335.065973610561, 2341.0869760793303, 2344.6600242964846, 2345.4019225097577, 2348.729896061949, 2266.841321107523, 2296.5062511560013, 2332.242021343062, 2336.7429582745885, 2338.1232037985756, 2051.5589148333106, 2133.1680644548637, 2133.925312614059, 2137.422895818136, 2144.774798646151, 2111.989440052805, 2265.524239909621, 2327.4297797039835, 2334.8248881333966, 2347.8473899196497, 8587.828243435159, 8635.39552231344, 8669.523176225304, 8736.563171841382, 8765.737027889174, 5169.147090730025, 5324.840254792362, 5331.786728530854, 5346.705931173784, 5362.4637536246455, 3010.5634682970845, 3608.314420260142, 3639.47227651989, 3644.3075815594952, 3699.7595156314756, 1014.3862962907408, 1042.791441711653, 1076.1122074288664, 1085.4247248958065, 1088.5754555723274, 11233.831492527619, 11272.985431311221, 11288.774224515546, 11297.830532542019, 11331.32012079278, 4340.696151269444, 4598.8620341389815, 4663.556962088596, 4669.2996050592, 4728.645351598644, 9623.230141588656, 9632.651428799974, 9632.662856800118, 9638.710838674851, 9643.324967252365, 4524.773761311922, 5257.237700533401, 5257.921131183035, 5258.973705131526, 5260.658057226345, 4575.977120114445, 4762.976185119052, 4821.156297647897, 4821.686590371614, 4824.228123500293, 3708.054446116223, 3760.3113773651426, 3779.281936432069, 3810.733248672622, 3858.2476417098956, 1239.5661518468644, 1249.0819247852821, 1259.0745801835644, 1266.5567051532075, 1267.9556215532411, 796.7092011415791, 847.8417893347232, 904.4708845325426, 906.2659246010752, 926.8645908761848, 5620.718964051781, 5644.209810626516, 5651.576131790132, 5657.886842263131, 5985.820425387245, 809.7611204694629, 896.6996056321075, 942.58997336159, 955.9139677429065, 959.8865316233137, 3291.4240007998505, 3439.518467414514, 3482.9651703483146, 3925.685945124383, 3984.143409167043, 10351.534180961875, 10415.42715150674, 10569.365838049742, 10575.471226438647, 10583.682489525327, 10532.842007369896, 10535.262531622713, 10553.525091370906, 10561.471926403803, 10581.4709264538, 7956.840863182704, 8206.958965205255, 8208.343332533383, 8211.137830527947, 8213.917860821435, 4943.728094954812, 5387.838364849061, 5607.0, 5799.0, 5817.621854579439, 9323.906760932576, 9724.805503889742, 9729.610815567297, 9741.220702343653, 9790.559424826042, 9545.093216144454, 9715.854262185932, 9855.605775769176, 9939.204863610748, 9955.352902061342, 6855.314468553105, 7929.0, 7937.166597507409, 8124.8781268279845, 8128.918710812816, 7965.800854978672, 8069.757907262557, 8154.143814899588, 8163.306118979954, 8168.0, 7250.709971601077, 7274.672639731119, 7311.707531698672, 7345.926540734525, 7371.705131794883, 7216.170140433707, 7219.386352159915, 7223.494355395072, 7246.492745507764, 7247.601381923834, 6700.793857105573, 6733.528652994243, 6880.105586273952, 6882.0, 6884.827879303058, 3248.5289633003554, 4224.619784219435, 4433.869363312464, 4908.607311415007, 4933.679310844784, 4867.0, 4877.024595081069, 4954.851354459372, 5024.899502009866, 5039.521245481674], "value": 4470.107071528926, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.7072668784591, 303.8101186758276, 308.5695454840497, 316.2788841441513, 318.0, 4831.251156070814, 5179.404368497624, 5278.868028299295, 5281.2342210379475, 5350.759215835287, 4359.803808828602, 4872.611305777854, 4902.391751753349, 5100.954304367605, 5111.105556527602, 3130.5773720547663, 3960.5643379228404, 4024.436578878952, 4029.9798501007454, 4039.2527382434196, 3503.9649603503894, 3987.2224916141363, 4005.3190957537145, 4018.4976877890263, 4063.3701776224584, 3008.5487176923416, 3793.279276937387, 3878.6897048236074, 3897.770918553373, 3990.2418540477215, 3239.838008099609, 3357.5489892378578, 3492.3189977954307, 3974.1256923477076, 4008.739431936944, 3168.1287645897332, 3302.6862448067636, 3512.683858452726, 3517.613062563116, 3535.6641119093647, 4262.531121576624, 4670.8365207217585, 5090.745462726849, 5100.413452452978, 5139.357580302462, 3494.52823868777, 4443.977780111111, 4481.64146868253, 4527.298268768346, 4573.588377046049, 4856.490068542823, 5441.0, 5542.334919809608, 5559.833205003856, 5594.825086731791, 3790.0, 3792.0, 3792.6017768134225, 3808.9619103808886, 3810.8475660973527, 5595.4964053235, 5700.37295897451, 5742.736597948445, 5769.942300576982, 5790.623609465371, 3500.457429098494, 3548.8757893473603, 3808.419505905074, 3809.4095415210686, 3810.6951443884423, 3829.885103446901, 3855.7879316637855, 3877.8254978526033, 3883.485440678138, 3883.572806991229, 4044.69664775143, 4137.882771651637, 4154.31453810124, 4483.663725220622, 4562.361269422284, 4896.653420309443, 4916.852494425173, 5416.350037995387, 5435.211894275387, 5580.776768929279, 1306.2097431054265, 1310.351376068852, 1318.2090745552591, 1321.4714114354335, 1327.9468821247042, 710.7974227345181, 717.5730440387961, 812.1837553259055, 837.5803013891517, 856.2935578148052, 4036.495438070241, 5121.667091639031, 5138.229265610188, 5138.58891288696, 5182.222666600041, 4551.362809206714, 4953.467577166852, 5531.170324451365, 5584.888302234014, 5633.774649013993, 4112.876613701594, 4736.715797052188, 4954.20732682769, 5289.862679523844, 5326.36083669962, 2853.7871404652938, 2887.232162028531, 2964.5325563846036, 2985.835524145585, 2988.3276262840686, 5682.460166284196, 5904.911426328608, 5922.808560832434, 5927.199828023248, 5943.791967281124, 4556.840510582114, 5289.3917199521775, 5496.587755918322, 5508.788066625336, 5866.325372582208, 5222.817201397933, 5239.659422137549, 5786.537077033827, 5803.593748437569, 5894.292684877928, 5210.775467764996, 5295.7352132394, 5605.551555875439, 5683.89164112994, 5721.685307307972, 4614.561616646413, 4675.906481870412, 4970.304157417892, 5209.4009188943755, 5697.686627235542, 5852.473277405054, 5905.287466634628, 5928.436798504135, 5945.464908158287, 5965.703204266475, 3232.062701816447, 3669.449582562637, 3785.4668859112103, 3801.3727734924532, 3831.9616803831605, 5686.886262274814, 5717.742701578356, 5740.856478588069, 5748.425157484218, 5766.682832444256, 5586.581006424616, 5589.55283577321, 5611.551075913999, 5612.418287587592, 5651.943480565142, 4691.780137164294, 5253.816116435906, 5355.3305836770405, 5512.200730894078, 5542.0, 5197.610179236497, 5377.704226267593, 5417.8103766367985, 5419.103313840124, 5423.701696406735, 4543.54564543543, 5342.919856202082, 5411.161270003156, 5419.945800542102, 5434.619576629756, 4079.8376860264107, 4563.452385713736, 4581.496035436166, 5384.434634363335, 5457.345118585795], "value": 3979.444991479088, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.8078118907895, 732.2018999290772, 770.7340967366257, 782.7416952405703, 820.4011071917496, 15398.692026159484, 15551.844481555181, 15558.222088895553, 15601.453949111783, 15631.296591653374, 14017.088889222194, 14164.0, 14165.92917035416, 14171.503997360094, 14186.645333866658, 696.96166710831, 726.61852527423, 731.8828987362023, 878.3324673248313, 901.2339511415311, 899.5771987166022, 903.1194585279366, 908.9818203635923, 910.3672947301628, 912.4479689787682, 966.7728083900278, 969.9127078562927, 970.1705042188933, 971.9319647624669, 973.7030205787232, 962.4658314635375, 963.0465838819588, 964.3538828984528, 964.392432767352, 965.0397854135146, 544.6568661743116, 556.3629644057572, 576.5848589015902, 705.0939542687622, 714.3606472207397, 14886.032407893452, 14917.701645967129, 14926.40294388223, 14964.176970266632, 14969.850301496954, 13299.268540230283, 13489.19064856102, 13502.0, 13546.729065418636, 13644.317784110755, 12114.273143611412, 12369.196002259914, 12493.375331233492, 12516.3741812909, 12713.93643031779, 4309.719868208556, 4340.761258130801, 4569.9314510282375, 4642.721436713808, 4649.3026046093355, 86590.56704716437, 86709.56645216797, 86823.0, 86925.13074869233, 87008.69486957701, 10333.22500812442, 10388.272820902615, 10592.328936480024, 10632.946835265775, 10712.839307410395, 20906.686399704016, 20954.580908381748, 20957.26649567258, 21001.369958901258, 21013.474663133544, 7617.352525035323, 7686.692532298645, 7705.345045671069, 7755.828368056953, 7799.142094369615, 4141.81361838718, 4266.573342665709, 4267.3812297217355, 4310.4180935573295, 4455.086707225011, 3378.7803792753393, 3489.755717099779, 3490.3193877193703, 3493.056874643832, 3505.369033573981, 547.258464780225, 586.4077281945266, 623.4700504571078, 640.3500447046251, 653.5033374635217, 598.1715324275822, 611.437477520682, 630.7949916277229, 633.1294470103608, 636.296891934415, 8493.405461617751, 8712.825743485095, 8815.515146666867, 8871.379003469696, 8972.68595599164, 583.7956715149663, 605.8592839754677, 616.765629060954, 627.2579300488322, 650.5413683353224, 4108.219438306712, 4252.149570085995, 4253.553376895444, 4318.201132790444, 4382.517923028464, 116597.0, 116957.8304216947, 117434.0, 118234.0, 119174.40412798054, 92305.0, 96332.0366796337, 105723.47138264413, 106278.0, 107886.46056769666, 61573.0, 70106.9483957741, 90512.0, 90924.99999999868, 91830.0, 8331.417030764136, 8410.158984101541, 8423.410361274651, 8471.449355791854, 8697.826043479221, 56388.43611563832, 57303.42696573148, 57850.842983140945, 60293.0956035651, 60495.39504604898, 65999.0, 75553.0, 82287.5885620568, 84122.0, 84689.57655211685, 11309.321440713584, 11332.263402878787, 11479.139064570023, 11815.940920295687, 11966.940165299466, 11762.94118529402, 11976.101792365433, 12071.155019148575, 12085.939570302093, 12516.561920332744, 11529.82705259405, 11644.592439264585, 11721.589744358907, 11767.352795596324, 11886.28682279066, 9662.275329350186, 11252.156088293246, 11573.444746521885, 11809.586664467046, 11892.762144756884, 11367.943160284145, 11402.087832973508, 11426.428678565871, 11433.828492572451, 11798.941005294919, 9485.857712134186, 9634.470104144058, 9797.118259356692, 9933.403995760278, 10033.799324013626, 8049.637766300648, 9319.720408387759, 9746.36648617866, 9807.607695692377, 9814.55834487464], "value": 7284.192095258281, "unit": "score"}], "name": "dromaeo_css", "value": 7094.916591537499, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 115.0, 114.0, 116.0, 115.0, 114.0, 114.0, 113.0, 112.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 113.0, 112.0, 148.0, 112.0, 121.0, 114.0, 112.0, 145.0, 113.0], "value": 124.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 183.0, 184.0, 187.0, 185.0, 179.0, 184.0, 181.0, 183.0], "value": 183.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 59.0, 86.0, 61.0, 60.0, 58.0, 58.0, 82.0, 57.0], "value": 66.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 88.0, 70.0, 67.0, 68.0, 119.0, 96.0, 96.0, 115.0], "value": 87.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 87.0, 85.0, 87.0, 85.0, 88.0, 84.0, 88.0, 83.0], "value": 86.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 159.0, 97.0, 98.0, 96.0, 96.0, 95.0, 95.0, 98.0, 96.0], "value": 108.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 85.0, 82.0, 82.0, 95.0, 131.0, 127.0, 86.0, 81.0, 81.0], "value": 93.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 53.0, 53.0, 55.0, 53.0, 54.0, 53.0, 55.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 67.0, 70.0, 79.0, 73.0, 70.0, 70.0, 72.0, 71.0, 70.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 87.0, 87.0, 90.0, 89.0, 89.0, 85.0, 87.0, 88.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 145.0, 143.0, 131.0, 151.0, 143.0, 153.0, 155.0, 204.0, 147.0], "value": 152.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 171.0, 172.0, 173.0, 171.0, 169.0, 171.0, 171.0, 172.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 68.0, 68.0, 69.0, 69.0, 69.0, 68.0, 68.0, 67.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1466.6000000000001, "alertThreshold": 2.0}]} 00:47:58 INFO - Return code: 0 00:47:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:47:58 INFO - # TBPL SUCCESS # 00:47:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:47:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:47:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:47:58 INFO - 2016-10-26 00:47:58.931 screenresolution[2328:288186] starting screenresolution argv=screenresolution get 00:47:58 INFO - 2016-10-26 00:47:58.934 screenresolution[2328:288186] Display 0: 1600x1200x32@60 00:47:58 INFO - 2016-10-26 00:47:58.940 screenresolution[2329:288189] starting screenresolution argv=screenresolution list 00:47:58 INFO - Available Modes on Display 0 00:47:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:47:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:47:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:47:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:47:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:47:59 INFO - Intel Iris: 00:47:59 INFO - Chipset Model: Intel Iris 00:47:59 INFO - Type: GPU 00:47:59 INFO - Bus: Built-In 00:47:59 INFO - VRAM (Dynamic, Max): 1536 MB 00:47:59 INFO - Vendor: Intel (0x8086) 00:47:59 INFO - Device ID: 0x0a2e 00:47:59 INFO - Revision ID: 0x0009 00:47:59 INFO - Displays: 00:47:59 INFO - Display: 00:47:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:47:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:47:59 INFO - Display Serial Number: 1600x1200 60 00:47:59 INFO - Main Display: Yes 00:47:59 INFO - Mirror: Off 00:47:59 INFO - Online: Yes 00:47:59 INFO - Rotation: Supported 00:47:59 INFO - Return code: 0 00:47:59 INFO - Running post-action listener: _resource_record_post_action 00:47:59 INFO - [mozharness: 2016-10-26 07:47:59.174817Z] Finished run-tests step (success) 00:47:59 INFO - Running post-run listener: _resource_record_post_run 00:47:59 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 868352; Write bytes: 709190656; Read time: 11; Write time: 1985 00:47:59 INFO - TinderboxPrint: CPU usage
53.6% 00:47:59 INFO - TinderboxPrint: I/O read bytes / time
868,352 / 11 00:47:59 INFO - TinderboxPrint: I/O write bytes / time
709,190,656 / 1,985 00:47:59 INFO - TinderboxPrint: CPU idle
2,249.6 (46.4%) 00:47:59 INFO - TinderboxPrint: CPU system
977.7 (20.1%) 00:47:59 INFO - TinderboxPrint: CPU user
1,626.2 (33.5%) 00:47:59 INFO - TinderboxPrint: Swap in / out
406,233,088 / 0 00:47:59 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 397023744; Write bytes: 391815680; Read time: 29411; Write time: 689 00:47:59 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 868352; Write bytes: 297862144; Read time: 11; Write time: 1232 00:47:59 INFO - Running post-run listener: _upload_blobber_files 00:47:59 INFO - Blob upload gear active. 00:47:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:47:59 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 00:47:59 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:47:59 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:48:00 INFO - (blobuploader) - INFO - Open directory for files ... 00:48:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:48:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:48:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:48:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:48:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:48:01 INFO - (blobuploader) - INFO - Done attempting. 00:48:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:48:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:48:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:48:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:48:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:48:02 INFO - (blobuploader) - INFO - Done attempting. 00:48:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:48:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:48:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:48:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:48:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:48:04 INFO - (blobuploader) - INFO - Done attempting. 00:48:04 INFO - (blobuploader) - INFO - Iteration through files over. 00:48:04 INFO - Return code: 0 00:48:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:48:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:48:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de56a838bb17a2947c961909b63e06b450801c14cd6247caa11e82d3ef726b70cff6b27f352a2da950f3d62dd878a2b65b042fb32fc45c7c20378078f1fe51b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/86cd889a48a28a537f5e7115694f7bef17bae5d85318d77c647231b735f0f99cacef45ee08388654682a9056a15c4a2d651c931225faccf46573a4631a740219", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/793d3b33b8be395a2bb883017d94d967fea2600c51755cd6bc3f627b938ae5e23cf13a55fcf4f327d7fbe6d720b24257d47ee3a6a6d0fc513cb4cf8e9504f405"} 00:48:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:48:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:48:04 INFO - Contents: 00:48:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de56a838bb17a2947c961909b63e06b450801c14cd6247caa11e82d3ef726b70cff6b27f352a2da950f3d62dd878a2b65b042fb32fc45c7c20378078f1fe51b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/86cd889a48a28a537f5e7115694f7bef17bae5d85318d77c647231b735f0f99cacef45ee08388654682a9056a15c4a2d651c931225faccf46573a4631a740219", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/793d3b33b8be395a2bb883017d94d967fea2600c51755cd6bc3f627b938ae5e23cf13a55fcf4f327d7fbe6d720b24257d47ee3a6a6d0fc513cb4cf8e9504f405"} 00:48:04 INFO - Running post-run listener: copy_logs_to_upload_dir 00:48:04 INFO - Copying logs to upload dir... 00:48:04 INFO - mkdir: /builds/slave/test/build/upload/logs 00:48:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.990567 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-26 00:48:04.400208) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 00:48:04.403972) ========= 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.UguUGQcNnj/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.MopbDxmpHu/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de56a838bb17a2947c961909b63e06b450801c14cd6247caa11e82d3ef726b70cff6b27f352a2da950f3d62dd878a2b65b042fb32fc45c7c20378078f1fe51b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/86cd889a48a28a537f5e7115694f7bef17bae5d85318d77c647231b735f0f99cacef45ee08388654682a9056a15c4a2d651c931225faccf46573a4631a740219", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/793d3b33b8be395a2bb883017d94d967fea2600c51755cd6bc3f627b938ae5e23cf13a55fcf4f327d7fbe6d720b24257d47ee3a6a6d0fc513cb4cf8e9504f405"} build_url:https://queue.taskcluster.net/v1/task/HtltD5jAS0qPIKFv1Rn9JQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011207 build_url: 'https://queue.taskcluster.net/v1/task/HtltD5jAS0qPIKFv1Rn9JQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de56a838bb17a2947c961909b63e06b450801c14cd6247caa11e82d3ef726b70cff6b27f352a2da950f3d62dd878a2b65b042fb32fc45c7c20378078f1fe51b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/86cd889a48a28a537f5e7115694f7bef17bae5d85318d77c647231b735f0f99cacef45ee08388654682a9056a15c4a2d651c931225faccf46573a4631a740219", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/793d3b33b8be395a2bb883017d94d967fea2600c51755cd6bc3f627b938ae5e23cf13a55fcf4f327d7fbe6d720b24257d47ee3a6a6d0fc513cb4cf8e9504f405"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 00:48:04.436192) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 00:48:04.436549) ========= 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.UguUGQcNnj/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.MopbDxmpHu/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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.005345 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 00:48:04.485484) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 00:48:04.485816) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 00:48:04.486142) ========= ========= Total master_lag: 0.17 =========