builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0067 starttime: 1482853337.15 results: success (0) buildid: 20161227063837 builduid: d2650c098b534fe594782f1b677cb839 revision: 2c316d8a97781a4c47d648bc87a00ff1d5155749 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-27 07:42:17.153235) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-27 07:42:17.153675) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-27 07:42:17.153964) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-27 07:42:17.264728) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 07:42:17.265104) ========= 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.9Ov0UW2o6U/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.3UDZXC90MU/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-27 07:42:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 100M=0s 2016-12-27 07:42:17 (100 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.155324 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 07:42:17.474163) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 07:42:17.474486) ========= 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.9Ov0UW2o6U/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.3UDZXC90MU/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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.026332 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 07:42:17.530853) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-27 07:42:17.531234) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2c316d8a97781a4c47d648bc87a00ff1d5155749 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2c316d8a97781a4c47d648bc87a00ff1d5155749 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9Ov0UW2o6U/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.3UDZXC90MU/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-27 07:42:17,625 truncating revision to first 12 chars 2016-12-27 07:42:17,626 Setting DEBUG logging. 2016-12-27 07:42:17,626 attempt 1/10 2016-12-27 07:42:17,626 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2c316d8a9778?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-27 07:42:18,606 unpacking tar archive at: mozilla-aurora-2c316d8a9778/testing/mozharness/ program finished with exit code 0 elapsedTime=1.250518 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-27 07:42:18.804839) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-27 07:42:18.805125) ========= script_repo_revision: 2c316d8a97781a4c47d648bc87a00ff1d5155749 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-27 07:42:18.805490) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-27 07:42:18.805763) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-27 07:42:18.825560) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-12-27 07:42:18.825844) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9Ov0UW2o6U/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.3UDZXC90MU/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 07:42:19 INFO - MultiFileLogger online at 20161227 07:42:19 in /builds/slave/test 07:42:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:42:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:42:19 INFO - {'append_to_log': False, 07:42:19 INFO - 'base_work_dir': '/builds/slave/test', 07:42:19 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:42:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:42:19 INFO - 'branch': 'Mozilla-Aurora', 07:42:19 INFO - 'buildbot_json_path': 'buildprops.json', 07:42:19 INFO - 'config_files': ('talos/mac_config.py',), 07:42:19 INFO - 'default_actions': ('clobber', 07:42:19 INFO - 'read-buildbot-config', 07:42:19 INFO - 'download-and-extract', 07:42:19 INFO - 'populate-webroot', 07:42:19 INFO - 'create-virtualenv', 07:42:19 INFO - 'install', 07:42:19 INFO - 'run-tests'), 07:42:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:42:19 INFO - 'download_minidump_stackwalk': True, 07:42:19 INFO - 'download_symbols': 'ondemand', 07:42:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:42:19 INFO - 'tooltool.py': '/tools/tooltool.py', 07:42:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:42:19 INFO - '/tools/misc-python/virtualenv.py')}, 07:42:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:42:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:42:19 INFO - 'installer_path': 'installer.exe', 07:42:19 INFO - 'log_level': 'info', 07:42:19 INFO - 'log_name': 'talos', 07:42:19 INFO - 'log_to_console': True, 07:42:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:42:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:42:19 INFO - 'opt_config_files': (), 07:42:19 INFO - 'pip_index': False, 07:42:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:42:19 INFO - 'cmd': ('bash', 07:42:19 INFO - '-c', 07:42:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:42:19 INFO - 'enabled': True, 07:42:19 INFO - 'halt_on_failure': False, 07:42:19 INFO - 'name': 'check_screen_resolution'},), 07:42:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:42:19 INFO - 'cmd': ('bash', 07:42:19 INFO - '-c', 07:42:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:42:19 INFO - 'enabled': True, 07:42:19 INFO - 'halt_on_failure': False, 07:42:19 INFO - 'name': 'check_screen_resolution'},), 07:42:19 INFO - 'run_cmd_checks_enabled': True, 07:42:19 INFO - 'sps_profile': False, 07:42:19 INFO - 'sps_profile_interval': 0, 07:42:19 INFO - 'suite': 'dromaeojs', 07:42:19 INFO - 'system_bits': '32', 07:42:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:42:19 INFO - 'title': 't-yosemite-r7-0067', 07:42:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:42:19 INFO - 'use_talos_json': True, 07:42:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:42:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:42:19 INFO - 'work_dir': 'build'} 07:42:19 INFO - [mozharness: 2016-12-27 15:42:19.034148Z] Running clobber step. 07:42:19 INFO - Running pre-action listener: _resource_record_pre_action 07:42:19 INFO - Running main action method: clobber 07:42:19 INFO - rmtree: /builds/slave/test/build 07:42:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:42:21 INFO - Running post-action listener: _resource_record_post_action 07:42:21 INFO - [mozharness: 2016-12-27 15:42:21.395782Z] Finished clobber step (success) 07:42:21 INFO - [mozharness: 2016-12-27 15:42:21.395904Z] Running read-buildbot-config step. 07:42:21 INFO - Running pre-action listener: _resource_record_pre_action 07:42:21 INFO - Running main action method: read_buildbot_config 07:42:21 INFO - Using buildbot properties: 07:42:21 INFO - { 07:42:21 INFO - "project": "", 07:42:21 INFO - "product": "firefox", 07:42:21 INFO - "script_repo_revision": "production", 07:42:21 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 07:42:21 INFO - "repository": "", 07:42:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 07:42:21 INFO - "buildid": "20161227063837", 07:42:21 INFO - "pgo_build": "False", 07:42:21 INFO - "basedir": "/builds/slave/test", 07:42:21 INFO - "buildnumber": 51, 07:42:21 INFO - "slavename": "t-yosemite-r7-0067", 07:42:21 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 07:42:21 INFO - "platform": "yosemite_r7", 07:42:21 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:42:21 INFO - "branch": "mozilla-aurora", 07:42:21 INFO - "repo_path": "releases/mozilla-aurora", 07:42:21 INFO - "revision": "2c316d8a97781a4c47d648bc87a00ff1d5155749", 07:42:21 INFO - "stage_platform": "macosx64", 07:42:21 INFO - "builduid": "d2650c098b534fe594782f1b677cb839", 07:42:21 INFO - "slavebuilddir": "test" 07:42:21 INFO - } 07:42:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 07:42:21 INFO - Running post-action listener: _resource_record_post_action 07:42:21 INFO - [mozharness: 2016-12-27 15:42:21.399310Z] Finished read-buildbot-config step (success) 07:42:21 INFO - [mozharness: 2016-12-27 15:42:21.399460Z] Running download-and-extract step. 07:42:21 INFO - Running pre-action listener: _resource_record_pre_action 07:42:21 INFO - Running main action method: download_and_extract 07:42:21 INFO - mkdir: /builds/slave/test/build/tests 07:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:21 INFO - trying https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 07:42:21 INFO - Downloading https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 07:42:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 07:42:22 INFO - Downloaded 1199 bytes. 07:42:22 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 07:42:22 INFO - Using the following test package requirements: 07:42:22 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 07:42:22 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:42:22 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 07:42:22 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:42:22 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 07:42:22 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:42:22 INFO - u'jsshell-mac.zip'], 07:42:22 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:42:22 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 07:42:22 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 07:42:22 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:42:22 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 07:42:22 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:42:22 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 07:42:22 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:42:22 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 07:42:22 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:42:22 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 07:42:22 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:42:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 07:42:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:42:22 INFO - Fetch https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 07:42:23 INFO - Http code: 200 07:42:23 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 07:42:23 INFO - x-amz-cf-id: USAi0s9vZMz7dN0WxR6W7mj1bWhns0r8OKkehFMaaXOEuoKKuiELkA== 07:42:23 INFO - x-amz-version-id: IPIKdDky3fPW8PBz9A.tyVVUdOEza9JP 07:42:23 INFO - Expected file size: 16268295 07:42:23 INFO - Obtained file size: 16268295 07:42:30 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 07:42:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 07:42:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:42:30 INFO - Fetch https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 07:42:30 INFO - Http code: 200 07:42:30 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 07:42:30 INFO - x-amz-cf-id: DJTdWkMzocIzOfBbokFhSaz6BLfqiE08I_9st-LzcSD5V4UQD38OfQ== 07:42:30 INFO - x-amz-version-id: IPIKdDky3fPW8PBz9A.tyVVUdOEza9JP 07:42:31 INFO - Expected file size: 16268295 07:42:31 INFO - Obtained file size: 16268295 07:42:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 07:42:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:42:37 INFO - Fetch https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 07:42:38 INFO - Http code: 200 07:42:38 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 07:42:38 INFO - x-amz-cf-id: 8zmjLi_CYPRcZplvhqsmTNzkXcHgEAGrfDoh3xw7WwVwyZNofSxxTA== 07:42:38 INFO - x-amz-version-id: aChfRBcaajeMMEV1tLA7M.Orj0qGv4KW 07:42:38 INFO - Expected file size: 14409038 07:42:38 INFO - Obtained file size: 14409038 07:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:38 INFO - trying https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:42:38 INFO - Downloading https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 07:42:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 07:42:41 INFO - Downloaded 109819866 bytes. 07:42:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:42:41 INFO - mkdir: /builds/slave/test/properties 07:42:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:42:41 INFO - Writing to file /builds/slave/test/properties/build_url 07:42:41 INFO - Contents: 07:42:41 INFO - build_url:https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:42:42 INFO - Running post-action listener: _resource_record_post_action 07:42:42 INFO - Running post-action listener: set_extra_try_arguments 07:42:42 INFO - [mozharness: 2016-12-27 15:42:42.215591Z] Finished download-and-extract step (success) 07:42:42 INFO - [mozharness: 2016-12-27 15:42:42.215741Z] Running populate-webroot step. 07:42:42 INFO - Running pre-action listener: _resource_record_pre_action 07:42:42 INFO - Running main action method: populate_webroot 07:42:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:42:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:42:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:42:42 INFO - '--tppagecycles', 07:42:42 INFO - '7'], 07:42:42 INFO - 'tests': ['tsvgm']}}, 07:42:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:42:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:42:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:42:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:42:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:42:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:42:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:42 INFO - 'talos_options': ['--disable-e10s'], 07:42:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:42:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:42:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:42 INFO - 'talos_options': ['--disable-e10s'], 07:42:42 INFO - 'tests': ['damp', 'tps']}, 07:42:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:42 INFO - 'tests': ['damp', 'tps']}, 07:42:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:42:42 INFO - 'tests': ['dromaeo_dom']}, 07:42:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:42:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:42:42 INFO - 'tests': ['basic_compositor_video']}, 07:42:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:42:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:42:42 INFO - 'tests': ['a11yr', 07:42:42 INFO - 'ts_paint', 07:42:42 INFO - 'tpaint', 07:42:42 INFO - 'sessionrestore', 07:42:42 INFO - 'sessionrestore_no_auto_restore', 07:42:42 INFO - 'tabpaint']}, 07:42:42 INFO - 'other-e10s': {'tests': ['a11yr', 07:42:42 INFO - 'ts_paint', 07:42:42 INFO - 'tpaint', 07:42:42 INFO - 'sessionrestore', 07:42:42 INFO - 'sessionrestore_no_auto_restore', 07:42:42 INFO - 'tabpaint']}, 07:42:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:42:42 INFO - 'ts_paint', 07:42:42 INFO - 'tpaint', 07:42:42 INFO - 'sessionrestore', 07:42:42 INFO - 'sessionrestore_no_auto_restore', 07:42:42 INFO - 'tabpaint']}, 07:42:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:42:42 INFO - 'ts_paint', 07:42:42 INFO - 'tpaint', 07:42:42 INFO - 'sessionrestore', 07:42:42 INFO - 'sessionrestore_no_auto_restore', 07:42:42 INFO - 'tabpaint']}, 07:42:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:42:42 INFO - 'tests': ['a11yr', 07:42:42 INFO - 'ts_paint', 07:42:42 INFO - 'tpaint', 07:42:42 INFO - 'sessionrestore', 07:42:42 INFO - 'sessionrestore_no_auto_restore', 07:42:42 INFO - 'tabpaint']}, 07:42:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:42:42 INFO - 'tests': ['a11yr', 07:42:42 INFO - 'ts_paint', 07:42:42 INFO - 'tpaint', 07:42:42 INFO - 'sessionrestore', 07:42:42 INFO - 'sessionrestore_no_auto_restore', 07:42:42 INFO - 'tabpaint']}, 07:42:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:42:42 INFO - 'tests': ['tsvgx', 07:42:42 INFO - 'tsvgr_opacity', 07:42:42 INFO - 'tart', 07:42:42 INFO - 'tscrollx', 07:42:42 INFO - 'cart']}, 07:42:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:42:42 INFO - 'tsvgr_opacity', 07:42:42 INFO - 'tart', 07:42:42 INFO - 'tscrollx', 07:42:42 INFO - 'cart']}, 07:42:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:42 INFO - 'talos_options': ['--disable-e10s'], 07:42:42 INFO - 'tests': ['tp5o']}, 07:42:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:42 INFO - 'tests': ['tp5o']}, 07:42:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:42 INFO - 'talos_options': ['--disable-e10s', 07:42:42 INFO - '--xperf_path', 07:42:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:42:42 INFO - 'tests': ['tp5n']}, 07:42:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:42 INFO - 'talos_options': ['--xperf_path', 07:42:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:42:42 INFO - 'tests': ['tp5n']}}, 07:42:42 INFO - 'talos.zip': {'path': '', 07:42:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:42:42 INFO - Running post-action listener: _resource_record_post_action 07:42:42 INFO - [mozharness: 2016-12-27 15:42:42.234663Z] Finished populate-webroot step (success) 07:42:42 INFO - [mozharness: 2016-12-27 15:42:42.234792Z] Running create-virtualenv step. 07:42:42 INFO - Running pre-action listener: _resource_record_pre_action 07:42:42 INFO - Running main action method: create_virtualenv 07:42:42 INFO - Creating virtualenv /builds/slave/test/build/venv 07:42:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:42:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:42:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:42:42 INFO - Using real prefix '/tools/python27' 07:42:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:42:43 INFO - Installing distribute.............................................................................................................................................................................................done. 07:42:45 INFO - Installing pip.................done. 07:42:45 INFO - Return code: 0 07:42:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:42:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:42:46 INFO - Reading from file tmpfile_stdout 07:42:46 INFO - Output received: 07:42:46 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:42:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ca98490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca0e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1bb4dd690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8acd30>, '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 0x10c712db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a4b20>, '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.9Ov0UW2o6U/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.3UDZXC90MU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:42:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:42:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:42:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ov0UW2o6U/Render', 07:42:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:46 INFO - 'HOME': '/Users/cltbld', 07:42:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:46 INFO - 'LOGNAME': 'cltbld', 07:42:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:46 INFO - 'MOZ_NO_REMOTE': '1', 07:42:46 INFO - 'NO_EM_RESTART': '1', 07:42:46 INFO - 'PAGER': '/bin/cat', 07:42:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:46 INFO - 'PWD': '/builds/slave/test', 07:42:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:46 INFO - 'SHELL': '/bin/bash', 07:42:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3UDZXC90MU/Listeners', 07:42:46 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 07:42:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:46 INFO - 'USER': 'cltbld', 07:42:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:46 INFO - 'XPC_FLAGS': '0x0', 07:42:46 INFO - 'XPC_SERVICE_NAME': '0', 07:42:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:42:46 INFO - Cleaning up... 07:42:46 INFO - Return code: 0 07:42:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ca98490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca0e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1bb4dd690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8acd30>, '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 0x10c712db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a4b20>, '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.9Ov0UW2o6U/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.3UDZXC90MU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:42:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:42:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:42:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ov0UW2o6U/Render', 07:42:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:46 INFO - 'HOME': '/Users/cltbld', 07:42:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:46 INFO - 'LOGNAME': 'cltbld', 07:42:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:46 INFO - 'MOZ_NO_REMOTE': '1', 07:42:46 INFO - 'NO_EM_RESTART': '1', 07:42:46 INFO - 'PAGER': '/bin/cat', 07:42:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:46 INFO - 'PWD': '/builds/slave/test', 07:42:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:46 INFO - 'SHELL': '/bin/bash', 07:42:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3UDZXC90MU/Listeners', 07:42:46 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 07:42:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:46 INFO - 'USER': 'cltbld', 07:42:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:46 INFO - 'XPC_FLAGS': '0x0', 07:42:46 INFO - 'XPC_SERVICE_NAME': '0', 07:42:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:46 INFO - Downloading/unpacking psutil>=3.1.1 07:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:42:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:42:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:42:50 INFO - Installing collected packages: psutil 07:42:50 INFO - Running setup.py install for psutil 07:42:50 INFO - building 'psutil._psutil_osx' extension 07:42:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:42:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:42:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:42:51 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:42:51 INFO - building 'psutil._psutil_posix' extension 07:42:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:42:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:42:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:42:51 INFO - ^ 07:42:51 INFO - 1 warning generated. 07:42:51 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:42:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:42:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:42:51 INFO - Successfully installed psutil 07:42:51 INFO - Cleaning up... 07:42:51 INFO - Return code: 0 07:42:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:42: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')]} 07:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42: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')]} 07:42:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:51 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 0x10ca98490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca0e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1bb4dd690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8acd30>, '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 0x10c712db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a4b20>, '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.9Ov0UW2o6U/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.3UDZXC90MU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:42:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:42:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ov0UW2o6U/Render', 07:42:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:52 INFO - 'HOME': '/Users/cltbld', 07:42:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:52 INFO - 'LOGNAME': 'cltbld', 07:42:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:52 INFO - 'MOZ_NO_REMOTE': '1', 07:42:52 INFO - 'NO_EM_RESTART': '1', 07:42:52 INFO - 'PAGER': '/bin/cat', 07:42:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:52 INFO - 'PWD': '/builds/slave/test', 07:42:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:52 INFO - 'SHELL': '/bin/bash', 07:42:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3UDZXC90MU/Listeners', 07:42:52 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 07:42:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:52 INFO - 'USER': 'cltbld', 07:42:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:52 INFO - 'XPC_FLAGS': '0x0', 07:42:52 INFO - 'XPC_SERVICE_NAME': '0', 07:42:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:42:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:42:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:42:54 INFO - Installing collected packages: mozsystemmonitor 07:42:54 INFO - Running setup.py install for mozsystemmonitor 07:42:55 INFO - Successfully installed mozsystemmonitor 07:42:55 INFO - Cleaning up... 07:42:55 INFO - Return code: 0 07:42:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:42:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:55 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 0x10ca98490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca0e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1bb4dd690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8acd30>, '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 0x10c712db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a4b20>, '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.9Ov0UW2o6U/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.3UDZXC90MU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:42:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:42:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ov0UW2o6U/Render', 07:42:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:55 INFO - 'HOME': '/Users/cltbld', 07:42:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:55 INFO - 'LOGNAME': 'cltbld', 07:42:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:55 INFO - 'MOZ_NO_REMOTE': '1', 07:42:55 INFO - 'NO_EM_RESTART': '1', 07:42:55 INFO - 'PAGER': '/bin/cat', 07:42:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:55 INFO - 'PWD': '/builds/slave/test', 07:42:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:55 INFO - 'SHELL': '/bin/bash', 07:42:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3UDZXC90MU/Listeners', 07:42:55 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 07:42:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:55 INFO - 'USER': 'cltbld', 07:42:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:55 INFO - 'XPC_FLAGS': '0x0', 07:42:55 INFO - 'XPC_SERVICE_NAME': '0', 07:42:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:55 INFO - Downloading/unpacking jsonschema==2.5.1 07:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:42:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:58 INFO - Downloading functools32-3.2.3-2.tar.gz 07:42:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:42:58 INFO - warning: no files found matching '*.txt' 07:42:58 INFO - no previously-included directories found matching 'build' 07:42:58 INFO - no previously-included directories found matching 'dist' 07:42:58 INFO - no previously-included directories found matching '.git*' 07:42:58 INFO - Installing collected packages: jsonschema, functools32 07:42:58 INFO - Running setup.py install for functools32 07:42:58 INFO - warning: no files found matching '*.txt' 07:42:58 INFO - no previously-included directories found matching 'build' 07:42:58 INFO - no previously-included directories found matching 'dist' 07:42:58 INFO - no previously-included directories found matching '.git*' 07:42:58 INFO - Successfully installed jsonschema functools32 07:42:58 INFO - Cleaning up... 07:42:58 INFO - Return code: 0 07:42:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:58 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 0x10ca98490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca0e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1bb4dd690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8acd30>, '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 0x10c712db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a4b20>, '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.9Ov0UW2o6U/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.3UDZXC90MU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:42:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:42:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:42:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ov0UW2o6U/Render', 07:42:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:58 INFO - 'HOME': '/Users/cltbld', 07:42:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:58 INFO - 'LOGNAME': 'cltbld', 07:42:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:58 INFO - 'MOZ_NO_REMOTE': '1', 07:42:58 INFO - 'NO_EM_RESTART': '1', 07:42:58 INFO - 'PAGER': '/bin/cat', 07:42:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:58 INFO - 'PWD': '/builds/slave/test', 07:42:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:58 INFO - 'SHELL': '/bin/bash', 07:42:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3UDZXC90MU/Listeners', 07:42:58 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 07:42:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:58 INFO - 'USER': 'cltbld', 07:42:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:58 INFO - 'XPC_FLAGS': '0x0', 07:42:58 INFO - 'XPC_SERVICE_NAME': '0', 07:42:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:42:59 INFO - Cleaning up... 07:42:59 INFO - Return code: 0 07:42:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:59 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 0x10ca98490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca0e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1bb4dd690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8acd30>, '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 0x10c712db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a4b20>, '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.9Ov0UW2o6U/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.3UDZXC90MU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:42:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:42:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:42:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ov0UW2o6U/Render', 07:42:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:59 INFO - 'HOME': '/Users/cltbld', 07:42:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:59 INFO - 'LOGNAME': 'cltbld', 07:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:59 INFO - 'MOZ_NO_REMOTE': '1', 07:42:59 INFO - 'NO_EM_RESTART': '1', 07:42:59 INFO - 'PAGER': '/bin/cat', 07:42:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:59 INFO - 'PWD': '/builds/slave/test', 07:42:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:59 INFO - 'SHELL': '/bin/bash', 07:42:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3UDZXC90MU/Listeners', 07:42:59 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 07:42:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:59 INFO - 'USER': 'cltbld', 07:42:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:59 INFO - 'XPC_FLAGS': '0x0', 07:42:59 INFO - 'XPC_SERVICE_NAME': '0', 07:42:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:59 INFO - Downloading/unpacking blobuploader==1.2.4 07:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:02 INFO - Downloading blobuploader-1.2.4.tar.gz 07:43:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:43:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:43:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:03 INFO - Downloading docopt-0.6.1.tar.gz 07:43:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:43:03 INFO - Installing collected packages: blobuploader, requests, docopt 07:43:03 INFO - Running setup.py install for blobuploader 07:43:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:43:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:43:03 INFO - Running setup.py install for requests 07:43:04 INFO - Running setup.py install for docopt 07:43:04 INFO - Successfully installed blobuploader requests docopt 07:43:04 INFO - Cleaning up... 07:43:04 INFO - Return code: 0 07:43:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:04 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 0x10ca98490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca0e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1bb4dd690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8acd30>, '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 0x10c712db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a4b20>, '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.9Ov0UW2o6U/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.3UDZXC90MU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:43:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:43:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:43:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ov0UW2o6U/Render', 07:43:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:43:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:43:04 INFO - 'HOME': '/Users/cltbld', 07:43:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:43:04 INFO - 'LOGNAME': 'cltbld', 07:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:04 INFO - 'MOZ_NO_REMOTE': '1', 07:43:04 INFO - 'NO_EM_RESTART': '1', 07:43:04 INFO - 'PAGER': '/bin/cat', 07:43:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:04 INFO - 'PWD': '/builds/slave/test', 07:43:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:43:04 INFO - 'SHELL': '/bin/bash', 07:43:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3UDZXC90MU/Listeners', 07:43:04 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 07:43:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:43:04 INFO - 'USER': 'cltbld', 07:43:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:43:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:04 INFO - 'XPC_FLAGS': '0x0', 07:43:04 INFO - 'XPC_SERVICE_NAME': '0', 07:43:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:43:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:43:04 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-mNQhtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:43:04 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-sl1aRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:43:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:43:04 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-oE7DTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:43:05 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-hmOYV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:43:05 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-gotO2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:43:05 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-vVjLXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:43:05 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-hNyfgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:43:05 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-zL_hoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:43:05 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-BXpRl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:43:05 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-0PHBok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:43:05 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-izYcf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:43:05 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-ZcHe0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:43:05 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-HmXxfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:43:06 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-BITSi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:06 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-kG6U3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:43:06 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-s48qYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:43:06 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-P94Hwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:43:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:43:06 INFO - Running setup.py install for manifestparser 07:43:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:43:06 INFO - Running setup.py install for mozcrash 07:43:06 INFO - Running setup.py install for mozdebug 07:43:06 INFO - Running setup.py install for mozdevice 07:43:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:43:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:43:07 INFO - Running setup.py install for mozfile 07:43:07 INFO - Running setup.py install for mozhttpd 07:43:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:43:07 INFO - Running setup.py install for mozinfo 07:43:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:43:07 INFO - Running setup.py install for mozInstall 07:43:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:43:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:43:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:43:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:43:07 INFO - Running setup.py install for mozleak 07:43:07 INFO - Running setup.py install for mozlog 07:43:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:43:07 INFO - Running setup.py install for moznetwork 07:43:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:43:08 INFO - Running setup.py install for mozprocess 07:43:08 INFO - Running setup.py install for mozprofile 07:43:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:43:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:43:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:43:08 INFO - Running setup.py install for mozrunner 07:43:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:43:08 INFO - Running setup.py install for mozscreenshot 07:43:08 INFO - Running setup.py install for moztest 07:43:08 INFO - Running setup.py install for mozversion 07:43:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:43:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:43:09 INFO - Cleaning up... 07:43:09 INFO - Return code: 0 07:43:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:43:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:09 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 0x10ca98490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca0e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1bb4dd690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8acd30>, '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 0x10c712db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a4b20>, '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.9Ov0UW2o6U/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.3UDZXC90MU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:43:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:43:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:43:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ov0UW2o6U/Render', 07:43:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:43:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:43:09 INFO - 'HOME': '/Users/cltbld', 07:43:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:43:09 INFO - 'LOGNAME': 'cltbld', 07:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:09 INFO - 'MOZ_NO_REMOTE': '1', 07:43:09 INFO - 'NO_EM_RESTART': '1', 07:43:09 INFO - 'PAGER': '/bin/cat', 07:43:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:09 INFO - 'PWD': '/builds/slave/test', 07:43:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:43:09 INFO - 'SHELL': '/bin/bash', 07:43:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3UDZXC90MU/Listeners', 07:43:09 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 07:43:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:43:09 INFO - 'USER': 'cltbld', 07:43:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:43:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:09 INFO - 'XPC_FLAGS': '0x0', 07:43:09 INFO - 'XPC_SERVICE_NAME': '0', 07:43:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:43:09 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-MN03DP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:43:09 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-KuNopM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:43:09 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-l6gEtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:43:09 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-EbBFvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:43:09 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-tRUQOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:43:09 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-4f9o0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:43:09 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-JJWv2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:43:10 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-ZAmUF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:43:10 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-ksR2G4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:43:10 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-fXv741-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:43:10 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-HHf5bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:43:10 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-tK3IKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:43:10 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-XVSzMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:43:10 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-zoEYP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:10 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-LcvIhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:43:10 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-BN1c72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:43:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:43:11 INFO - Running setup.py (path:/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/pip-KTpEUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:43:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:43:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:43:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:43:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:43:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:43:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:43:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:13 INFO - Downloading blessings-1.6.tar.gz 07:43:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:43:13 INFO - Installing collected packages: blessings 07:43:13 INFO - Running setup.py install for blessings 07:43:13 INFO - Successfully installed blessings 07:43:13 INFO - Cleaning up... 07:43:14 INFO - Return code: 0 07:43:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:43:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:43:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:43:14 INFO - Reading from file tmpfile_stdout 07:43:14 INFO - Current package versions: 07:43:14 INFO - blessings == 1.6 07:43:14 INFO - blobuploader == 1.2.4 07:43:14 INFO - docopt == 0.6.1 07:43:14 INFO - functools32 == 3.2.3-2 07:43:14 INFO - jsonschema == 2.5.1 07:43:14 INFO - manifestparser == 1.1 07:43:14 INFO - mozInstall == 1.12 07:43:14 INFO - mozcrash == 1.0 07:43:14 INFO - mozdebug == 0.1 07:43:14 INFO - mozdevice == 0.48 07:43:14 INFO - mozfile == 1.2 07:43:14 INFO - mozhttpd == 0.7 07:43:14 INFO - mozinfo == 0.9 07:43:14 INFO - mozleak == 0.1 07:43:14 INFO - mozlog == 3.4 07:43:14 INFO - moznetwork == 0.27 07:43:14 INFO - mozprocess == 0.23 07:43:14 INFO - mozprofile == 0.28 07:43:14 INFO - mozrunner == 6.13 07:43:14 INFO - mozscreenshot == 0.1 07:43:14 INFO - mozsystemmonitor == 0.3 07:43:14 INFO - moztest == 0.7 07:43:14 INFO - mozversion == 1.4 07:43:14 INFO - psutil == 3.1.1 07:43:14 INFO - requests == 1.2.3 07:43:14 INFO - wsgiref == 0.1.2 07:43:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:14 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 0x10ca98490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca0e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1bb4dd690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8acd30>, '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 0x10c712db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a4b20>, '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.9Ov0UW2o6U/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.3UDZXC90MU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:43:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:43:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:43:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ov0UW2o6U/Render', 07:43:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:43:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:43:14 INFO - 'HOME': '/Users/cltbld', 07:43:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:43:14 INFO - 'LOGNAME': 'cltbld', 07:43:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:14 INFO - 'MOZ_NO_REMOTE': '1', 07:43:14 INFO - 'NO_EM_RESTART': '1', 07:43:14 INFO - 'PAGER': '/bin/cat', 07:43:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:43:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:14 INFO - 'PWD': '/builds/slave/test', 07:43:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:43:14 INFO - 'SHELL': '/bin/bash', 07:43:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3UDZXC90MU/Listeners', 07:43:14 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 07:43:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:43:14 INFO - 'USER': 'cltbld', 07:43:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:43:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:43:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:14 INFO - 'XPC_FLAGS': '0x0', 07:43:14 INFO - 'XPC_SERVICE_NAME': '0', 07:43:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:43:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:43:14 INFO - Cleaning up... 07:43:14 INFO - Return code: 0 07:43:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:14 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 0x10ca98490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca0e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1bb4dd690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8acd30>, '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 0x10c712db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a4b20>, '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.9Ov0UW2o6U/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.3UDZXC90MU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:43:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:43:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:43:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ov0UW2o6U/Render', 07:43:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:43:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:43:14 INFO - 'HOME': '/Users/cltbld', 07:43:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:43:14 INFO - 'LOGNAME': 'cltbld', 07:43:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:14 INFO - 'MOZ_NO_REMOTE': '1', 07:43:14 INFO - 'NO_EM_RESTART': '1', 07:43:14 INFO - 'PAGER': '/bin/cat', 07:43:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:43:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:14 INFO - 'PWD': '/builds/slave/test', 07:43:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:43:14 INFO - 'SHELL': '/bin/bash', 07:43:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3UDZXC90MU/Listeners', 07:43:14 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 07:43:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:43:14 INFO - 'USER': 'cltbld', 07:43:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:43:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:43:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:14 INFO - 'XPC_FLAGS': '0x0', 07:43:14 INFO - 'XPC_SERVICE_NAME': '0', 07:43:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:43:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:43:14 INFO - Cleaning up... 07:43:14 INFO - Return code: 0 07:43:14 INFO - Running post-action listener: _resource_record_post_action 07:43:14 INFO - Running post-action listener: _start_resource_monitoring 07:43:14 INFO - Starting resource monitoring. 07:43:14 INFO - [mozharness: 2016-12-27 15:43:14.935878Z] Finished create-virtualenv step (success) 07:43:14 INFO - [mozharness: 2016-12-27 15:43:14.936883Z] Running install step. 07:43:14 INFO - Running pre-action listener: _resource_record_pre_action 07:43:14 INFO - Running main action method: install 07:43:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:43:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:43:15 INFO - Reading from file tmpfile_stdout 07:43:15 INFO - Detecting whether we're running mozinstall >=1.0... 07:43:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:43:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:43:15 INFO - Reading from file tmpfile_stdout 07:43:15 INFO - Output received: 07:43:15 INFO - Usage: mozinstall [options] installer 07:43:15 INFO - Options: 07:43:15 INFO - -h, --help show this help message and exit 07:43:15 INFO - -d DEST, --destination=DEST 07:43:15 INFO - Directory to install application into. [default: 07:43:15 INFO - "/builds/slave/test"] 07:43:15 INFO - --app=APP Application being installed. [default: firefox] 07:43:15 INFO - mkdir: /builds/slave/test/build/application 07:43:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:43:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 07:43:47 INFO - Reading from file tmpfile_stdout 07:43:47 INFO - Output received: 07:43:47 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:43:47 INFO - Running post-action listener: _resource_record_post_action 07:43:47 INFO - [mozharness: 2016-12-27 15:43:47.079156Z] Finished install step (success) 07:43:47 INFO - [mozharness: 2016-12-27 15:43:47.079311Z] Running run-tests step. 07:43:47 INFO - Running pre-action listener: _resource_record_pre_action 07:43:47 INFO - Running main action method: run_tests 07:43:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:43:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:43:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:43:47 INFO - 2016-12-27 07:43:47.093 screenresolution[1639:14270] starting screenresolution argv=screenresolution get 07:43:47 INFO - 2016-12-27 07:43:47.096 screenresolution[1639:14270] Display 0: 1600x1200x32@60 07:43:47 INFO - 2016-12-27 07:43:47.102 screenresolution[1640:14272] starting screenresolution argv=screenresolution list 07:43:47 INFO - Available Modes on Display 0 07:43:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:43:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:43:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:43:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:43:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:43:47 INFO - Intel Iris: 07:43:47 INFO - Chipset Model: Intel Iris 07:43:47 INFO - Type: GPU 07:43:47 INFO - Bus: Built-In 07:43:47 INFO - VRAM (Dynamic, Max): 1536 MB 07:43:47 INFO - Vendor: Intel (0x8086) 07:43:47 INFO - Device ID: 0x0a2e 07:43:47 INFO - Revision ID: 0x0009 07:43:47 INFO - Displays: 07:43:47 INFO - Display: 07:43:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:43:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:43:47 INFO - Display Serial Number: 1600x1200 60 07:43:47 INFO - Main Display: Yes 07:43:47 INFO - Mirror: Off 07:43:47 INFO - Online: Yes 07:43:47 INFO - Rotation: Supported 07:43:47 INFO - Return code: 0 07:43:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:43:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:43:47 INFO - Python 2.7.3 07:43:47 INFO - Return code: 0 07:43:47 INFO - grabbing minidump binary from tooltool 07:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:47 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 0x10c8acd30>, '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 0x10c712db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:43:47 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:43:47 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:43:47 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:43:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:43:47 INFO - Return code: 0 07:43:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:43:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:43:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:43:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:43:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:43:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0067', '--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 07:43:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0067 --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 07:43:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9Ov0UW2o6U/Render', 07:43:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:43:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:43:47 INFO - 'HOME': '/Users/cltbld', 07:43:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:43:47 INFO - 'LOGNAME': 'cltbld', 07:43:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:43:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:43:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:47 INFO - 'MOZ_NO_REMOTE': '1', 07:43:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:43:47 INFO - 'NO_EM_RESTART': '1', 07:43:47 INFO - 'PAGER': '/bin/cat', 07:43:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:43:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:47 INFO - 'PWD': '/builds/slave/test', 07:43:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:43:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:43:47 INFO - 'SHELL': '/bin/bash', 07:43:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3UDZXC90MU/Listeners', 07:43:47 INFO - 'TMPDIR': '/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/', 07:43:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:43:47 INFO - 'USER': 'cltbld', 07:43:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:43:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:43:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:47 INFO - 'XPC_FLAGS': '0x0', 07:43:47 INFO - 'XPC_SERVICE_NAME': '0', 07:43:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:43:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0067', '--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 07:43:47 INFO - mozversion application_buildid: 20161227063837 07:43:47 INFO - mozversion application_changeset: 2c316d8a97781a4c47d648bc87a00ff1d5155749 07:43:47 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:43:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:43:47 INFO - mozversion application_name: Firefox 07:43:47 INFO - mozversion application_remotingname: firefox-dev 07:43:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:43:47 INFO - mozversion application_vendor: Mozilla 07:43:47 INFO - mozversion application_version: 52.0a2 07:43:47 INFO - mozversion platform_buildid: 20161227063837 07:43:47 INFO - mozversion platform_changeset: 2c316d8a97781a4c47d648bc87a00ff1d5155749 07:43:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:43:47 INFO - mozversion platform_version: 52.0a2 07:43:47 INFO - using testdate: 1482853427 07:43:47 INFO - actual date: 1482853427 07:43:47 INFO - starting webserver on 'localhost:49246' 07:43:47 INFO - SUITE-START | Running 2 tests 07:43:47 INFO - TEST-START | dromaeo_css 07:43:47 INFO - operating with platform_type : mac_ 07:43:47 INFO - Initialising browser for dromaeo_css test... 07:43:47 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmpllWuW6/profile http://localhost:49246/getInfo.html) 07:43:50 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 07:43:50 INFO - PROCESS | 1650 | colorDepth:24 07:43:50 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 07:43:50 INFO - PROCESS | 1650 | __metrics 07:43:50 INFO - PROCESS | 1650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:43:50 INFO - PROCESS | 1650 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:43:51 INFO - TEST-INFO | 1650: exit 0 07:43:51 INFO - Browser initialized. 07:43:51 INFO - Running cycle 1/1 for dromaeo_css test... 07:43:51 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmpllWuW6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:44:03 INFO - PROCESS | 1653 | RSS: Main: 222720000 07:44:03 INFO - PROCESS | 1653 | 07:44:54 INFO - PROCESS | 1653 | 1482853494605 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:47:08 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 07:47:10 INFO - PROCESS | 1653 | RSS: Main: 392732672 07:47:10 INFO - PROCESS | 1653 | 07:50:13 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 07:50:14 INFO - PROCESS | 1653 | RSS: Main: 348999680 07:50:14 INFO - PROCESS | 1653 | 07:53:16 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 07:53:17 INFO - PROCESS | 1653 | RSS: Main: 325799936 07:53:17 INFO - PROCESS | 1653 | 07:56:19 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 07:56:20 INFO - PROCESS | 1653 | RSS: Main: 334553088 07:56:20 INFO - PROCESS | 1653 | 07:59:23 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 07:59:24 INFO - PROCESS | 1653 | RSS: Main: 315379712 07:59:24 INFO - PROCESS | 1653 | 08:02:27 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 08:02:27 INFO - PROCESS | 1653 | RSS: Main: 506761216 08:02:27 INFO - PROCESS | 1653 | 08:02:27 INFO - PROCESS | 1653 | __start_tp_report 08:02:27 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 08:02:27 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 08:02:27 INFO - PROCESS | 1653 | |i|pagename|runs| 08:02:27 INFO - PROCESS | 1653 | |0;dojo.html;3214.164317277508;3253.9023829285115;3254.3979363817693;3268.8365581720936;3288.736901047915;5434.809781657643;5469.699166545838;5471.945280547194;5485.451454854512;5509.2011658309575;5412.404635490093;5484.808031718891;5499.202615620733;5502.159422822472;5535.169724541311;4986.700797952125;4998.875028124307;5005.6496045276845;5050.747462626872;5155.922661160085;4992.375953005874;5005.249212618118;5046.697198168104;5127.435982041972;5136.383633963911;5020.899582008357;5068.72122033288;5069.771860266297;5074.517920797518;5076.543111119999;5055.9241611375855;5080.212567052113;5080.720560369178;5082.059818933509;5088.821891233826;4899.779509922062;5030.094582975063;5032.345795046621;5041.621878359138;5048.444671086178;5509.449055094498;5518.696471694056;5520.337559492847;5530.778768849241;5548.500634942875;5828.475437210672;5833.358330583633;5834.095715164156;5835.416458354173;5836.241288632493;4349.391085248068;5928.79249226275;5941.584089113764;5942.435468630473;6035.124906888521;5508.9724551377385;5513.531349835269;5534;5545.1682247663175;5557.527610153142;5143.665661731976;6210.472109870667;6222.937770622327;6231.688415579249;6233.937660623426;5604.747786349624;5637.041702910515;5664.348599911063;5672.12082127271;5716.942830571641;5628.465295796893;5988.520918326523;5989.071693887455;6001.309849367379;6005.309389420186;5944.881102377928;5953.523718102541;5954.37479064692;5957.017092179828;5991.670458124845;5796.014677504834;5844.094165404369;5851.21008663825;5971.5222782177325;6017.939820601826;4751.4535828379485;4770.475247722748;4787.640926930494;4791.401074865642;4793.304970779218;3654.3056819204267;4275.657947364203;4302.118065796504;4305.375720520507;4330.7401555906745;5344.91982620261;5423.647462914898;5481.232627432163;5513.42109078549;5517.972410137923;5876.324222714357;5896.734646940898;5923.4668879800165;5924.14099955504;5926.644401335933;5455.5908306876345;5457.317835270591;5503.284573005563;5521.944780552143;5557.638753481011;5205.401378841481;5207.5313221809465;5210.426853046162;5212.4266330703595;5221.347331583552;6152.723127459186;6186.1648677427975;6198.81403557885;6227.377262273736;6250.874982500415;5850.94149058504;5915.08316210988;5927.4665280125;5950.583459157818;6029.246344206974;6239.532035097477;6240.188775459162;6243.719032643633;6251.468625166912;6252.187215661935;5828.979928512578;5872.207252020922;5887.0580707086665;5913.970430147821;5924.763009479572;5798.681072540882;5859.736311865891;5887.852803679771;6053.757849685963;6056.454919057306;5693.345265294379;5694.202811606461;5726.599138060295;5756.280464941882;5778.971105144447;4991.675541089818;5556.721953950695;5722.284714410699;5735.512481439125;5755.942440575541;5534.833954981357;5598.412166722435;5645.604807663424;5652.3217213934595;5657.32112146545;5694.060480020916;5756.884862302814;5766.769329226784;5777.24895763548;5777.422257774189;5609.49514543693;5644.576656750678;5646.435356464321;5653.575981801299;5663.150527420919 08:02:27 INFO - PROCESS | 1653 | |1;ext.html;507.4823679846554;512.7205672908267;524.4755244755244;528.3501293409107;544.5697898660059;23862.761372386292;37870.43194352084;38924.610753892455;39062.60937390625;39164.412533812014;34445.65554344462;38574;39563.80218098913;39968;40026.199476010464;9188.264938804896;9358.57886395114;9359.251259899193;9360.251179905625;9374.10945960136;9318.86021709675;9414.52927353633;9420.952895235514;9426.905730942672;9444.102810233016;8072.3138533224455;9068.455892646429;9448.57481413338;9450.905490945072;9459.10138536838;9306.162445379949;9337;9389.342746007747;9405.482698451582;9406.670766523208;9235.815283694355;9320.067993200693;9327.673531426435;9330.673426430043;9347.112024357675;38001;38343.80828095869;38411.807940960396;38427.807860960515;38447.231055379016;3241.9351612967844;3304.9504257436156;3350.430426827445;3449.275652113059;3571.4642803579673;27600.723992760017;28270.434591308265;29357.119286421443;29670.70329296701;30339.393212135856;3109.129443755752;3138.3409484008384;3149.2756665966726;3219.114743445548;3241.8865339713234;490160;493853.530732344;493959;494262.52868735784;494548;32274;56687.43312566821;57116.428835711115;57137.71431142818;57195;33488.83255583706;34323.97028089161;34738.131546711025;34741;34758.13104672403;13653.863461365458;13673.794893076612;14040;14175.574732758034;14234.359453824603;11466.08271338291;11474.770504589862;11877.990370818578;11980.28118312904;12005.339706316236;7675.002249707502;7727.072751269883;7749.651265693057;7756.6509507072315;7782.416318776114;3175.25381535339;3220.2915358621067;3220.372027454624;3230.2570408806105;3261.8695252190123;877.2323767608275;881.7487016200353;959.6641175588488;981.7692842182081;990.2375171118199;23589;26575.601365979524;28198.29504262369;28235.76463530487;28992.710072899423;982.8549739553483;1029.2897900448816;1034.7102811212872;1037.7976294622476;1051.952662130206;14581.270936453135;14613.634659133606;14678.853211467962;15075.54773356801;15145.469908553368;673336;943249;949759;951532;953913;44928.55071449309;55405.1689224662;55472.89054218893;55535;55710.60723481864;1211.8182272658996;1255.5417272695584;1263.7472505498938;1354.1468874608934;1375.2985977151525;23887.283381498582;27674;29480.705192948655;30358.544621831134;31285.687143128278;51918.96162076813;52822.47177528175;52909.735451324035;52919;53045.469545304055;593583;600885;602446;603812;604064;39165.608343916196;39596.604033959295;40638.796806016966;40654.39018414785;40705.79647101746;43280.78359608182;43709;43802.34296485491;44135.77932110447;44185.779071104436;36322.09194770152;36647.26705465929;36692.81653591715;36771.44842827306;37781.622183777814;36860.89417317485;36884.446733299555;37362.8131859339;37472.81263593664;37522.2495550082;29270.853645731637;30035.399292014474;35857.282854342244;36249.81875090607;36268.27463450769;31353.216169595944;32771.34457310888;33155.83422082874;33208.66791332152;33230.003099907044;24058;24272.27183184507;24322;24784;24823.379415514755 08:02:27 INFO - PROCESS | 1653 | |2;jquery.html;343.23287452543576;343.3887679929724;360.4683092438653;361.6889475051454;372.9123655940853;14762.852371476281;15298.541043768691;16895.32418703252;20033.998300084975;20080.59838803223;18490.72263916039;19784.802151978474;19799.40601781949;19834.20663173475;19871.701924471145;5620.437956204378;5833.300003999526;5860.150278209657;5890.970545147268;5895.587308888358;4083.9795801020955;4351.891202719941;5115.897682046357;6350.555461117724;6505.967470162666;6302.527310451712;6315.842103947392;6456.677166141698;6474.935250647504;6507.51193660475;6430.48556115512;6463.48292136628;6484.902726459107;6486.545941784077;6491.22105347359;5361.758720857571;5542.91685624716;5607.775688972436;5608.775648974077;5638.295213098363;24054.917528711074;24704.876475617508;24876.3780905477;24878.875605622037;25148.11981580636;2197.9010944507536;2328.2084091408833;2361.7874391304695;2567.4865026994676;2770.542860428027;14057.437702491889;14448.566543003726;14526.854731452762;15048.623784405368;15052.247387630574;1755.692009452953;1773.9556511087196;1812.465322729798;1904.1241029126618;1929.3729537900238;110185;115498.42250788776;121031;123582.76417235803;125090.12364814535;8673;9297.302702297355;10546.683599492027;10846.67459976202;11038.889611103947;13520.12119212248;13599.388027538784;13604.795928061087;13613.387397567134;13623.659408514668;7880.802979925547;8414.410991230678;8453.112423195598;8527.40308178434;8569.185927336894;8300.2114799094;8373.1626837317;8396.328293736486;8550.828983420297;8567.143285671384;6410.871782564416;6520.217573891068;6522.347765223534;6540.640264785387;6673.966630166915;1639.9750156152404;1767.45208985215;1838.5383620022114;1843.6773564626137;1883.510287325278;815.6248125862052;871.1270767849174;938.2728385501155;963.4123184857232;980.4509474694194;19775.703364449546;21312.57374852494;21367.8931605341;21415.447566268424;21510.677339839916;882.4176043811054;911.5077857956629;920.4385324951774;941.204682043672;956.8660387545749;10692.679219623267;11387.544498219979;11391.544338226544;11422.600208992812;11482.827757583644;582475;590985;591276;608322;611344;72490;89249.55375223083;115249;116013.35946562044;116590;936.8969413364524;973.454865275448;982.9164521015794;983.7884854756119;984.2618036472645;18803.905980470012;19226.519337016685;19407.417777466697;19456.513587160433;19498.8050119497;41420.585794141676;49273;49894.75052624714;50095.99808003747;52648.21027684664;63460.68269658622;73781;78036.60981695056;80807.59596202217;81010;7840.607969601611;7854.952013456156;8001.3598912088055;8062.475939063942;8317.251447369767;8837.55812209374;10256.948715256376;12489.625311240678;12577.310324516302;12672.239665620093;10614.681559553226;10627.36235825853;10863.67408977732;11094.611688590861;11189.608363707557;9269.72190834276;10048.49757512136;10728.624498142528;10820;11201.383923884265;10875.966783155587;10917.290376125526;10940.234183607072;11186.161037922026;11355.37545434976;7702.345300649507;7884.44808863397;7897.1707970662255;8233.217844304781;8307.252347288531;10450.843237351293;10585.9470702646;10728.946355268174;10752.838707419238;11144.609938652433 08:02:27 INFO - PROCESS | 1653 | |3;mootools.html;1450.5648305508346;1451.2163431746858;1604.7191741445251;1748;1794.1567463292256;8006.479578827372;8412.495250284986;8427.662893484254;8431.62057707403;8446.113158118402;7335.633218339075;7608.961955190216;7635.121960974489;7939.682412703485;8254.298384637297;2270.2281224383746;2307.065638416436;2333.6149535326736;2337.403961989699;2340.8127349811975;2310.503241803012;2352.717673879137;2377.4888398994212;2382.65451509531;2383.7497062808416;2280.3728974532055;2316.4903721181313;2342.02805835578;2347.530493901218;2352.7059117610297;2263.0495192019393;2293.736220334666;2323.1984965187066;2327.5810354136247;2333.1484008337006;2315.4674424882205;2343.308723926446;2347.2371479269304;2348.7533808949984;2351.259353303704;8081.7171399001345;8217.753467395987;8227.012758468962;8232.50604963704;8246.917530824734;4988.87527811804;5158.045761534128;5159.2003239497935;5162;5170.896582068338;3099.178717639827;3279.262166012652;3297.196553507487;3415.9146021349416;3426.4517677171784;988.8566157907063;1003.8042581696573;1023.8566600675912;1026.2508368890751;1035.5391850626474;10391.428471434068;10655.041046305792;10661.413622250773;10668.253222274443;10861;4497.302918047708;4568.954310456853;4654.348391225231;4660.603848672833;4715.95284047162;9332.90667093334;9386.15524602789;9392;9397.859032114524;9403.247740180768;5170.793168273227;5174.09453345663;5176.404713457925;5178.922316165261;5188.325517682752;4175.332185100432;4241.660667146621;4546;4678.251479763221;4737.644676649196;3752.193278445093;3770.472133901256;3864.4589757433982;3889;3889.416587511896;1225.0934308611563;1248.7689777391213;1252.330003448169;1258.2387655468492;1274.7641686288066;787.2757063501592;856.3491746272878;884.7920738626418;905.4160066756905;913.6071489259682;5468.250159948858;5499.7250137492965;5500.1749737539685;5508.20131080999;5616.466435688603;434.4547592771115;449.3843434494763;449.99100017999456;450.9594136527728;455.130700362313;3606.6213047630145;3629.927401452009;3631.328204282216;3637.2725454909123;3746.3818469952153;7755;9752.804943901083;9863.309568330147;9864.704058878246;9936.254780891462;9794.363366381162;9812.607495700093;9814.803703925882;9818.803623927624;9820;7344.339009489172;7535.472516923763;7581.128170260491;7734.187910269453;7739;4567.1779079765965;5158.664686795346;5411.269478620493;5465.535429488538;5584.078627026495;8981.640734370552;9117.270618350649;9184.678536251466;9270.258379329503;9279.860802087838;9287.72136835896;9325.347225694137;9348.485833279236;9354.579043942902;9436.669716559887;7007.649617519001;7038.01467794499;7042.401395881203;7104.076470059066;7125.429965602636;7606.706859833731;7688.038995125609;7697.6151192441275;7704.422168337285;7718.53688778675;6808.353206445379;6911.343422374866;6913.1358580177475;7003.5797852129035;7061.505694601328;6773.491988101011;6817.659117044227;6841.760538381132;6869.519133660596;6883.552569082994;5295.602829787705;6384.106225128578;6453.16108905858;6454.870902581828;6476.676166191577;4664.743439110882;4667.906641867075;4707.388039554836;4739;4836.347093142522;4552.817887284472;4742.810287588458;4831.323614693875;4838.854834354975;4858.7570621469495 08:02:27 INFO - PROCESS | 1653 | |4;prototype.html;294.13230968642506;295.10435827264246;303.532559857819;309.9535069739539;310.42726170215946;5004.924926126111;5160.561352285055;5175;5184.740762961856;5216.487218706576;3933.350997085485;4452.438049560347;4860.8055677772845;5184.403793563732;5216.5826733861295;4000.5799391063956;4003.8198281077275;4028.63742263197;4035.4955630546033;4038.2731108400476;3128.499440089586;3545.574531056264;3925.7437619961624;4038.4144299076615;4040.5353384360883;3598.9280214395694;3915.318007165087;3936.8505195843354;3960.980195099035;3962.9405558916637;3590.850927703123;3595.712343012579;3617.94573081404;3932.3315036443732;3940.7241493095494;2849.843258620775;3248.658890816454;3399.5920489541413;3438.2951494943477;3457.3949558827103;4689;5096.974515127437;5119.948800511985;5134.409542902539;5142.871428214287;3616.8553257869653;4532.4334458192725;4536.274196128604;4542.318652202163;4542.841000564964;5141.76862041209;5358.115910874701;5507.972460137714;5517.317218248473;5528.530074943635;3185.8566364513654;3734.402495600691;3769.6230376962085;3778.6761141897537;3805.0297174220673;4794.856154315376;5618.410066942994;5675.31896172462;5698.658080515141;5729.226554415142;3669.486271921933;3797.848086076526;3821.178446633987;3821.7515861468914;3826.7129965252716;3777.99883030997;3832.7125465590193;3848.7883166425554;3859.4017927221325;3874.4769456123627;3894.805259737002;4449.3993310902615;4480.910381792346;4481.484629267611;4486.75050191277;4368.541303163186;4765.594924431392;5473.143736202305;5491.007400966483;5492.395836457987;1056.2131212246925;1072.7318170457386;1162.9940101811872;1239.5971309324505;1242.944067516964;828.3662997806682;843.333766324609;853.8249658819927;854.43607219235;855.8189698216421;4152.584741525884;4161.791910404529;4183.184279065553;4281.422008028939;4878.95121048792;4514.887127821765;4856.73287969158;5287.735613219324;5299.006061575197;5301.787928482818;4271.124419493996;4663.95061111254;4811.711297322172;4835.138471688355;4843.830465933675;2560.4879024195234;2626.1858823764696;2764.751172394494;2788.567771995344;2803.971960280371;4662.813487460531;4702.741349225826;5492.457364999553;5503;5509.173623956439;4644.210484217691;5290;5399.464449862135;5413.566914646819;5451.182322651634;5191.480851914778;5249.97625463031;5528.391876893538;5907.518842086334;5922.585419020627;4495.887602809956;5675.055836193806;5702.5764050279295;5715.942550628147;5719.685417302088;4183.058811767328;4629.745364005012;4848.903021939471;5083.212102124176;5679.460451257124;4739.824317707214;5142.614303927146;5549.944500554942;5853.678047707417;5923.585349025527;3638.072291565634;3662.50556174913;3808.466814645896;3837.76973381598;3847.3651847445976;4384.344195987268;5201.063808514353;5609.88780224385;5647.604667673223;5727.914081288701;5511.724413779375;5516.393196748435;5520.806771762969;5542.63972841764;5547.362053363915;5061.013102445135;5513.421090785409;5522.641028333145;5546.4453554644215;5579.972100139474;4208.305629571087;4639.536046395334;5415.756290966995;5435.565154787529;5453.509184173444;4610.838620648261;4728.361671174347;5260.368755749335;5510.91733623988;5547.639403438763;4503.437070366204;5418.241446197457;5425.593080519056;5431.23962645222;5446.618736688552 08:02:27 INFO - PROCESS | 1653 | |5;yui.html;670.6378555579987;681.8806708825956;712.1774350625027;721.6968873073308;778.0740918307214;13697.520586779465;14390.280485975713;14438.5668429947;14445.566633001026;14451.13293202406;12702.491900324;12849.357532123404;12850.293233872133;12856.100072994894;12857.678558036054;791.6239786101598;808.975730728079;814.8044469327349;824.8556502612049;828.362161135925;819.0580832043139;819.4550623835142;820.2125959079291;823.8105235795771;824.3075816314295;856.4989481153533;859;859.3597769661611;859.3683642522741;861.2894362151219;847.3348421489133;853.4708480741917;854.6111519258784;854.9615267312955;856.4818284937647;632.7184402940693;633.0946746152999;633.2527617411453;633.9524535659798;636.7262077306756;13768.655783605389;14024.649383765487;14043.64890877726;14079.929600351932;14099.78850317246;12880.227186368847;13103.934480327633;13129.277889716062;13131.212127272394;13318.533851315255;10548.156147508182;11024.393658348788;11163.051140653055;11193.440327983568;11636;3500.282442099389;3517.9120521987156;3540.274243780019;3574;3628.2924829658227;66327.66836165884;82629;83402.58298708528;85270;86391.13608863894;9967.302288839712;10080.798384032425;10301.845472317922;10337.276390652582;10542.789144217226;18811.15349809262;19105;19121.330753423565;19141.80858191428;19155.712664310046;6246.28286695289;6318.862604731193;7118.572885626775;7404.037475128306;7463.440241981873;3641.7997010164695;3667.211549516867;4164.229617520768;4235.449391579136;4237.665135482313;2967.925801854971;3313.7017668409476;3421.4183588789965;3443.4146195146886;3708.313961917054;688.8656711941123;692.5221597098086;692.9757458488929;696.8745326753382;707.9539829911039;558.3746204251264;559.7481133489946;581.7818318130701;625.7090452939404;642.7814543055383;8882.467051976902;9597.712068637951;9629.951850240705;9897.554610042565;10015.349002314826;508.9745512724349;544.2271973797217;589.7876764364826;666.4768156996735;674.7604600366898;4134.586541345901;4379.321205213197;4402.471703395613;4419.40338054365;4499.797509112098;62182;80340.59829700814;97758.53362199572;98041.50979245058;99874;56076;61243.6937815317;65610.34389656138;67017.32982670111;84095;71930.64034679793;75153.62423187958;76322.6183869077;77223;82151;9045;9509.476978765957;9546.056449093077;9547.570359333708;9631.9036809631;41296.76109716713;42357.57642423536;45222.54777452315;49738.50261497339;51874.74062629814;51117.72205694739;56546.717266413405;69537.2615684612;72215.63892180506;72262;11846.229995050295;11899.345535995604;11912.642620721392;11960.880391195977;12245.57140500114;13039.413226405024;13432.992525560818;13464.730705385642;13702;13748.793768093687;12120.212186207867;12802.16785908913;12809.551665691655;12897.935510322388;13109.344532773133;12157.574484892986;12459.93770031144;12484.750304993668;12596.937015315232;13066.934665326613;12007.879921200676;12138.150329476852;12996.350182490649;13119.147255428366;13296;10210.132138768287;10268.229882758673;10879.836802448128;11107.666769996913;11315.20793544444;8428.243741897026;9025.729228123168;9988.400695958266;10115.190784737057;10138.543765530421 08:02:27 INFO - PROCESS | 1653 | __end_tp_report 08:02:27 INFO - PROCESS | 1653 | __start_cc_report 08:02:27 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1891 08:02:27 INFO - PROCESS | 1653 | __end_cc_report 08:02:27 INFO - PROCESS | 1653 | __startTimestamp1482854547261__endTimestamp 08:02:27 INFO - PROCESS | 1653 | 08:02:27 INFO - PROCESS | 1653 | ------- Summary: start ------- 08:02:27 INFO - PROCESS | 1653 | Number of tests: 6 08:02:27 INFO - PROCESS | 1653 | 08:02:27 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5484.00 Median:5609.50 stddev:607.24 (10.8%) stddev-sans-first:582.41 08:02:27 INFO - PROCESS | 1653 | Values: 3214.2 3253.9 3254.4 3268.8 3288.7 5434.8 5469.7 5471.9 5485.5 5509.2 5412.4 5484.8 5499.2 5502.2 5535.2 4986.7 4998.9 5005.6 5050.7 5155.9 4992.4 5005.2 5046.7 5127.4 5136.4 5020.9 5068.7 5069.8 5074.5 5076.5 5055.9 5080.2 5080.7 5082.1 5088.8 4899.8 5030.1 5032.3 5041.6 5048.4 5509.4 5518.7 5520.3 5530.8 5548.5 5828.5 5833.4 5834.1 5835.4 5836.2 4349.4 5928.8 5941.6 5942.4 6035.1 5509.0 5513.5 5534.0 5545.2 5557.5 5143.7 6210.5 6222.9 6231.7 6233.9 5604.7 5637.0 5664.3 5672.1 5716.9 5628.5 5988.5 5989.1 6001.3 6005.3 5944.9 5953.5 5954.4 5957.0 5991.7 5796.0 5844.1 5851.2 5971.5 6017.9 4751.5 4770.5 4787.6 4791.4 4793.3 3654.3 4275.7 4302.1 4305.4 4330.7 5344.9 5423.6 5481.2 5513.4 5518.0 5876.3 5896.7 5923.5 5924.1 5926.6 5455.6 5457.3 5503.3 5521.9 5557.6 5205.4 5207.5 5210.4 5212.4 5221.3 6152.7 6186.2 6198.8 6227.4 6250.9 5850.9 5915.1 5927.5 5950.6 6029.2 6239.5 6240.2 6243.7 6251.5 6252.2 5829.0 5872.2 5887.1 5914.0 5924.8 5798.7 5859.7 5887.9 6053.8 6056.5 5693.3 5694.2 5726.6 5756.3 5779.0 4991.7 5556.7 5722.3 5735.5 5755.9 5534.8 5598.4 5645.6 5652.3 5657.3 5694.1 5756.9 5766.8 5777.2 5777.4 5609.5 5644.6 5646.4 5653.6 5663.2 08:02:27 INFO - PROCESS | 1653 | 08:02:27 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:75992.68 Median:38419.81 stddev:185753.81 (483.5%) stddev-sans-first:186188.43 08:02:27 INFO - PROCESS | 1653 | Values: 507.5 512.7 524.5 528.4 544.6 23862.8 37870.4 38924.6 39062.6 39164.4 34445.7 38574.0 39563.8 39968.0 40026.2 9188.3 9358.6 9359.3 9360.3 9374.1 9318.9 9414.5 9421.0 9426.9 9444.1 8072.3 9068.5 9448.6 9450.9 9459.1 9306.2 9337.0 9389.3 9405.5 9406.7 9235.8 9320.1 9327.7 9330.7 9347.1 38001.0 38343.8 38411.8 38427.8 38447.2 3241.9 3305.0 3350.4 3449.3 3571.5 27600.7 28270.4 29357.1 29670.7 30339.4 3109.1 3138.3 3149.3 3219.1 3241.9 490160.0 493853.5 493959.0 494262.5 494548.0 32274.0 56687.4 57116.4 57137.7 57195.0 33488.8 34324.0 34738.1 34741.0 34758.1 13653.9 13673.8 14040.0 14175.6 14234.4 11466.1 11474.8 11878.0 11980.3 12005.3 7675.0 7727.1 7749.7 7756.7 7782.4 3175.3 3220.3 3220.4 3230.3 3261.9 877.2 881.7 959.7 981.8 990.2 23589.0 26575.6 28198.3 28235.8 28992.7 982.9 1029.3 1034.7 1037.8 1052.0 14581.3 14613.6 14678.9 15075.5 15145.5 673336.0 943249.0 949759.0 951532.0 953913.0 44928.6 55405.2 55472.9 55535.0 55710.6 1211.8 1255.5 1263.7 1354.1 1375.3 23887.3 27674.0 29480.7 30358.5 31285.7 51919.0 52822.5 52909.7 52919.0 53045.5 593583.0 600885.0 602446.0 603812.0 604064.0 39165.6 39596.6 40638.8 40654.4 40705.8 43280.8 43709.0 43802.3 44135.8 44185.8 36322.1 36647.3 36692.8 36771.4 37781.6 36860.9 36884.4 37362.8 37472.8 37522.2 29270.9 30035.4 35857.3 36249.8 36268.3 31353.2 32771.3 33155.8 33208.7 33230.0 24058.0 24272.3 24322.0 24784.0 24823.4 08:02:27 INFO - PROCESS | 1653 | 08:02:27 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:34060.49 Median:351.93 stddev:99089.12 (28156.0%) stddev-sans-first:99334.75 08:02:27 INFO - PROCESS | 1653 | Values: 343.2 343.4 360.5 361.7 372.9 14762.9 15298.5 16895.3 20034.0 20080.6 18490.7 19784.8 19799.4 19834.2 19871.7 5620.4 5833.3 5860.2 5891.0 5895.6 4084.0 4351.9 5115.9 6350.6 6506.0 6302.5 6315.8 6456.7 6474.9 6507.5 6430.5 6463.5 6484.9 6486.5 6491.2 5361.8 5542.9 5607.8 5608.8 5638.3 24054.9 24704.9 24876.4 24878.9 25148.1 2197.9 2328.2 2361.8 2567.5 2770.5 14057.4 14448.6 14526.9 15048.6 15052.2 1755.7 1774.0 1812.5 1904.1 1929.4 110185.0 115498.4 121031.0 123582.8 125090.1 8673.0 9297.3 10546.7 10846.7 11038.9 13520.1 13599.4 13604.8 13613.4 13623.7 7880.8 8414.4 8453.1 8527.4 8569.2 8300.2 8373.2 8396.3 8550.8 8567.1 6410.9 6520.2 6522.3 6540.6 6674.0 1640.0 1767.5 1838.5 1843.7 1883.5 815.6 871.1 938.3 963.4 980.5 19775.7 21312.6 21367.9 21415.4 21510.7 882.4 911.5 920.4 941.2 956.9 10692.7 11387.5 11391.5 11422.6 11482.8 582475.0 590985.0 591276.0 608322.0 611344.0 72490.0 89249.6 115249.0 116013.4 116590.0 936.9 973.5 982.9 983.8 984.3 18803.9 19226.5 19407.4 19456.5 19498.8 41420.6 49273.0 49894.8 50096.0 52648.2 63460.7 73781.0 78036.6 80807.6 81010.0 7840.6 7855.0 8001.4 8062.5 8317.3 8837.6 10256.9 12489.6 12577.3 12672.2 10614.7 10627.4 10863.7 11094.6 11189.6 9269.7 10048.5 10728.6 10820.0 11201.4 10876.0 10917.3 10940.2 11186.2 11355.4 7702.3 7884.4 7897.2 8233.2 8307.3 10450.8 10585.9 10728.9 10752.8 11144.6 08:02:27 INFO - PROCESS | 1653 | 08:02:27 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5325.01 Median:5170.84 stddev:2920.59 (56.5%) stddev-sans-first:2914.26 08:02:27 INFO - PROCESS | 1653 | Values: 1450.6 1451.2 1604.7 1748.0 1794.2 8006.5 8412.5 8427.7 8431.6 8446.1 7335.6 7609.0 7635.1 7939.7 8254.3 2270.2 2307.1 2333.6 2337.4 2340.8 2310.5 2352.7 2377.5 2382.7 2383.7 2280.4 2316.5 2342.0 2347.5 2352.7 2263.0 2293.7 2323.2 2327.6 2333.1 2315.5 2343.3 2347.2 2348.8 2351.3 8081.7 8217.8 8227.0 8232.5 8246.9 4988.9 5158.0 5159.2 5162.0 5170.9 3099.2 3279.3 3297.2 3415.9 3426.5 988.9 1003.8 1023.9 1026.3 1035.5 10391.4 10655.0 10661.4 10668.3 10861.0 4497.3 4569.0 4654.3 4660.6 4716.0 9332.9 9386.2 9392.0 9397.9 9403.2 5170.8 5174.1 5176.4 5178.9 5188.3 4175.3 4241.7 4546.0 4678.3 4737.6 3752.2 3770.5 3864.5 3889.0 3889.4 1225.1 1248.8 1252.3 1258.2 1274.8 787.3 856.3 884.8 905.4 913.6 5468.3 5499.7 5500.2 5508.2 5616.5 434.5 449.4 450.0 451.0 455.1 3606.6 3629.9 3631.3 3637.3 3746.4 7755.0 9752.8 9863.3 9864.7 9936.3 9794.4 9812.6 9814.8 9818.8 9820.0 7344.3 7535.5 7581.1 7734.2 7739.0 4567.2 5158.7 5411.3 5465.5 5584.1 8981.6 9117.3 9184.7 9270.3 9279.9 9287.7 9325.3 9348.5 9354.6 9436.7 7007.6 7038.0 7042.4 7104.1 7125.4 7606.7 7688.0 7697.6 7704.4 7718.5 6808.4 6911.3 6913.1 7003.6 7061.5 6773.5 6817.7 6841.8 6869.5 6883.6 5295.6 6384.1 6453.2 6454.9 6476.7 4664.7 4667.9 4707.4 4739.0 4836.3 4552.8 4742.8 4831.3 4838.9 4858.8 08:02:27 INFO - PROCESS | 1653 | 08:02:27 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4330.11 Median:4695.87 stddev:1340.80 (28.6%) stddev-sans-first:1309.89 08:02:27 INFO - PROCESS | 1653 | Values: 294.1 295.1 303.5 310.0 310.4 5004.9 5160.6 5175.0 5184.7 5216.5 3933.4 4452.4 4860.8 5184.4 5216.6 4000.6 4003.8 4028.6 4035.5 4038.3 3128.5 3545.6 3925.7 4038.4 4040.5 3598.9 3915.3 3936.9 3961.0 3962.9 3590.9 3595.7 3617.9 3932.3 3940.7 2849.8 3248.7 3399.6 3438.3 3457.4 4689.0 5097.0 5119.9 5134.4 5142.9 3616.9 4532.4 4536.3 4542.3 4542.8 5141.8 5358.1 5508.0 5517.3 5528.5 3185.9 3734.4 3769.6 3778.7 3805.0 4794.9 5618.4 5675.3 5698.7 5729.2 3669.5 3797.8 3821.2 3821.8 3826.7 3778.0 3832.7 3848.8 3859.4 3874.5 3894.8 4449.4 4480.9 4481.5 4486.8 4368.5 4765.6 5473.1 5491.0 5492.4 1056.2 1072.7 1163.0 1239.6 1242.9 828.4 843.3 853.8 854.4 855.8 4152.6 4161.8 4183.2 4281.4 4879.0 4514.9 4856.7 5287.7 5299.0 5301.8 4271.1 4664.0 4811.7 4835.1 4843.8 2560.5 2626.2 2764.8 2788.6 2804.0 4662.8 4702.7 5492.5 5503.0 5509.2 4644.2 5290.0 5399.5 5413.6 5451.2 5191.5 5250.0 5528.4 5907.5 5922.6 4495.9 5675.1 5702.6 5715.9 5719.7 4183.1 4629.7 4848.9 5083.2 5679.5 4739.8 5142.6 5549.9 5853.7 5923.6 3638.1 3662.5 3808.5 3837.8 3847.4 4384.3 5201.1 5609.9 5647.6 5727.9 5511.7 5516.4 5520.8 5542.6 5547.4 5061.0 5513.4 5522.6 5546.4 5580.0 4208.3 4639.5 5415.8 5435.6 5453.5 4610.8 4728.4 5260.4 5510.9 5547.6 4503.4 5418.2 5425.6 5431.2 5446.6 08:02:27 INFO - PROCESS | 1653 | 08:02:27 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:18013.37 Median:25123.74 stddev:24910.74 (99.2%) stddev-sans-first:24946.59 08:02:27 INFO - PROCESS | 1653 | Values: 670.6 681.9 712.2 721.7 778.1 13697.5 14390.3 14438.6 14445.6 14451.1 12702.5 12849.4 12850.3 12856.1 12857.7 791.6 809.0 814.8 824.9 828.4 819.1 819.5 820.2 823.8 824.3 856.5 859.0 859.4 859.4 861.3 847.3 853.5 854.6 855.0 856.5 632.7 633.1 633.3 634.0 636.7 13768.7 14024.6 14043.6 14079.9 14099.8 12880.2 13103.9 13129.3 13131.2 13318.5 10548.2 11024.4 11163.1 11193.4 11636.0 3500.3 3517.9 3540.3 3574.0 3628.3 66327.7 82629.0 83402.6 85270.0 86391.1 9967.3 10080.8 10301.8 10337.3 10542.8 18811.2 19105.0 19121.3 19141.8 19155.7 6246.3 6318.9 7118.6 7404.0 7463.4 3641.8 3667.2 4164.2 4235.4 4237.7 2967.9 3313.7 3421.4 3443.4 3708.3 688.9 692.5 693.0 696.9 708.0 558.4 559.7 581.8 625.7 642.8 8882.5 9597.7 9630.0 9897.6 10015.3 509.0 544.2 589.8 666.5 674.8 4134.6 4379.3 4402.5 4419.4 4499.8 62182.0 80340.6 97758.5 98041.5 99874.0 56076.0 61243.7 65610.3 67017.3 84095.0 71930.6 75153.6 76322.6 77223.0 82151.0 9045.0 9509.5 9546.1 9547.6 9631.9 41296.8 42357.6 45222.5 49738.5 51874.7 51117.7 56546.7 69537.3 72215.6 72262.0 11846.2 11899.3 11912.6 11960.9 12245.6 13039.4 13433.0 13464.7 13702.0 13748.8 12120.2 12802.2 12809.6 12897.9 13109.3 12157.6 12459.9 12484.8 12596.9 13066.9 12007.9 12138.2 12996.4 13119.1 13296.0 10210.1 10268.2 10879.8 11107.7 11315.2 8428.2 9025.7 9988.4 10115.2 10138.5 08:02:27 INFO - PROCESS | 1653 | -------- Summary: end -------- 08:02:27 INFO - PROCESS | 1653 | 08:02:27 INFO - TEST-INFO | 1653: exit 0 08:02:27 INFO - TEST-OK | dromaeo_css | took 1120244ms 08:02:27 INFO - TEST-START | kraken 08:02:27 INFO - operating with platform_type : mac_ 08:02:27 INFO - Initialising browser for kraken test... 08:02:27 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmpkF9Dd5/profile http://localhost:49246/getInfo.html) 08:02:30 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 08:02:30 INFO - PROCESS | 1659 | colorDepth:24 08:02:30 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 08:02:30 INFO - PROCESS | 1659 | __metrics 08:02:30 INFO - PROCESS | 1659 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:02:30 INFO - PROCESS | 1659 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:02:31 INFO - TEST-INFO | 1659: exit 0 08:02:31 INFO - Browser initialized. 08:02:31 INFO - Running cycle 1/1 for kraken test... 08:02:31 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/tmpkF9Dd5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:02:43 INFO - PROCESS | 1660 | RSS: Main: 222306304 08:02:43 INFO - PROCESS | 1660 | 08:02:46 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 08:02:47 INFO - PROCESS | 1660 | RSS: Main: 270458880 08:02:47 INFO - PROCESS | 1660 | 08:02:49 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 08:02:50 INFO - PROCESS | 1660 | RSS: Main: 285601792 08:02:50 INFO - PROCESS | 1660 | 08:02:53 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 08:02:54 INFO - PROCESS | 1660 | RSS: Main: 382013440 08:02:54 INFO - PROCESS | 1660 | 08:02:56 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 08:02:57 INFO - PROCESS | 1660 | RSS: Main: 283279360 08:02:57 INFO - PROCESS | 1660 | 08:02:59 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:02:59 INFO - PROCESS | 1660 | RSS: Main: 285552640 08:02:59 INFO - PROCESS | 1660 | 08:03:02 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 08:03:03 INFO - PROCESS | 1660 | RSS: Main: 324993024 08:03:03 INFO - PROCESS | 1660 | 08:03:06 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 08:03:06 INFO - PROCESS | 1660 | RSS: Main: 325902336 08:03:06 INFO - PROCESS | 1660 | 08:03:09 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 08:03:10 INFO - PROCESS | 1660 | RSS: Main: 323346432 08:03:10 INFO - PROCESS | 1660 | 08:03:11 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:03:12 INFO - PROCESS | 1660 | RSS: Main: 299499520 08:03:12 INFO - PROCESS | 1660 | 08:03:14 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:03:14 INFO - PROCESS | 1660 | RSS: Main: 301613056 08:03:14 INFO - PROCESS | 1660 | 08:03:17 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:03:17 INFO - PROCESS | 1660 | RSS: Main: 303501312 08:03:17 INFO - PROCESS | 1660 | 08:03:20 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:03:21 INFO - PROCESS | 1660 | RSS: Main: 322060288 08:03:21 INFO - PROCESS | 1660 | 08:03:24 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:03:25 INFO - PROCESS | 1660 | RSS: Main: 314912768 08:03:25 INFO - PROCESS | 1660 | 08:03:26 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 08:03:26 INFO - PROCESS | 1660 | RSS: Main: 359247872 08:03:26 INFO - PROCESS | 1660 | 08:03:26 INFO - PROCESS | 1660 | __start_tp_report 08:03:26 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 08:03:26 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 08:03:26 INFO - PROCESS | 1660 | |i|pagename|runs| 08:03:26 INFO - PROCESS | 1660 | |0;ai-astar;103;113;113;113;114;113;113;113;114;114 08:03:26 INFO - PROCESS | 1660 | |1;audio-beat-detection;142;111;112;144;111;109;110;115;171;114 08:03:26 INFO - PROCESS | 1660 | |2;audio-dft;181;182;186;186;186;184;185;186;220;264 08:03:26 INFO - PROCESS | 1660 | |3;audio-fft;82;59;62;88;61;59;60;59;82;58 08:03:26 INFO - PROCESS | 1660 | |4;audio-oscillator;84;72;95;69;68;70;92;67;68;93 08:03:26 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;90;86;89;86;89;86;89;86;90;86 08:03:26 INFO - PROCESS | 1660 | |6;imaging-darkroom;95;95;101;96;90;131;146;94;94;94 08:03:26 INFO - PROCESS | 1660 | |7;imaging-desaturate;84;81;79;80;83;84;84;83;82;84 08:03:26 INFO - PROCESS | 1660 | |8;json-parse-financial;55;54;82;86;87;59;59;58;58;59 08:03:26 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;64;70;70;79;73;69;69;69;70;72 08:03:26 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;85;84;82;98;100;100;95;79;87;75 08:03:26 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;149;150;144;130;150;141;134;149;209;167 08:03:26 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;167;166;168;166;167;159;168;166;168;167 08:03:26 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;70;68;69;67;69;68;68;67;68;67 08:03:26 INFO - PROCESS | 1660 | __end_tp_report 08:03:26 INFO - PROCESS | 1660 | __start_cc_report 08:03:26 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,2074 08:03:26 INFO - PROCESS | 1660 | __end_cc_report 08:03:26 INFO - PROCESS | 1660 | __startTimestamp1482854606990__endTimestamp 08:03:26 INFO - PROCESS | 1660 | 08:03:26 INFO - PROCESS | 1660 | ------- Summary: start ------- 08:03:26 INFO - PROCESS | 1660 | Number of tests: 14 08:03:26 INFO - PROCESS | 1660 | 08:03:26 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:3.30 (2.9%) stddev-sans-first:0.50 08:03:26 INFO - PROCESS | 1660 | Values: 103.0 113.0 113.0 113.0 114.0 113.0 113.0 113.0 114.0 114.0 08:03:27 INFO - PROCESS | 1660 | 08:03:27 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:123.90 Median:114.50 stddev:21.13 (18.5%) stddev-sans-first:21.37 08:03:27 INFO - PROCESS | 1660 | Values: 142.0 111.0 112.0 144.0 111.0 109.0 110.0 115.0 171.0 114.0 08:03:27 INFO - PROCESS | 1660 | 08:03:27 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:196.00 Median:186.00 stddev:26.43 (14.2%) stddev-sans-first:27.47 08:03:27 INFO - PROCESS | 1660 | Values: 181.0 182.0 186.0 186.0 186.0 184.0 185.0 186.0 220.0 264.0 08:03:27 INFO - PROCESS | 1660 | 08:03:27 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:67.00 Median:61.50 stddev:11.90 (19.3%) stddev-sans-first:11.31 08:03:27 INFO - PROCESS | 1660 | Values: 82.0 59.0 62.0 88.0 61.0 59.0 60.0 59.0 82.0 58.0 08:03:27 INFO - PROCESS | 1660 | 08:03:27 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:78.00 stddev:11.77 (15.1%) stddev-sans-first:12.27 08:03:27 INFO - PROCESS | 1660 | Values: 84.0 72.0 95.0 69.0 68.0 70.0 92.0 67.0 68.0 93.0 08:03:27 INFO - PROCESS | 1660 | 08:03:27 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:87.70 Median:89.00 stddev:1.83 (2.1%) stddev-sans-first:1.74 08:03:27 INFO - PROCESS | 1660 | Values: 90.0 86.0 89.0 86.0 89.0 86.0 89.0 86.0 90.0 86.0 08:03:27 INFO - PROCESS | 1660 | 08:03:27 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:103.60 Median:94.00 stddev:18.92 (20.1%) stddev-sans-first:19.81 08:03:27 INFO - PROCESS | 1660 | Values: 95.0 95.0 101.0 96.0 90.0 131.0 146.0 94.0 94.0 94.0 08:03:27 INFO - PROCESS | 1660 | 08:03:27 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:82.40 Median:83.50 stddev:1.84 (2.2%) stddev-sans-first:1.86 08:03:27 INFO - PROCESS | 1660 | Values: 84.0 81.0 79.0 80.0 83.0 84.0 84.0 83.0 82.0 84.0 08:03:27 INFO - PROCESS | 1660 | 08:03:27 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:59.00 stddev:13.48 (22.9%) stddev-sans-first:13.73 08:03:27 INFO - PROCESS | 1660 | Values: 55.0 54.0 82.0 86.0 87.0 59.0 59.0 58.0 58.0 59.0 08:03:27 INFO - PROCESS | 1660 | 08:03:27 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:70.50 Median:70.00 stddev:3.81 (5.4%) stddev-sans-first:3.23 08:03:27 INFO - PROCESS | 1660 | Values: 64.0 70.0 70.0 79.0 73.0 69.0 69.0 69.0 70.0 72.0 08:03:27 INFO - PROCESS | 1660 | 08:03:27 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:84.50 stddev:9.11 (10.8%) stddev-sans-first:9.57 08:03:27 INFO - PROCESS | 1660 | Values: 85.0 84.0 82.0 98.0 100.0 100.0 95.0 79.0 87.0 75.0 08:03:27 INFO - PROCESS | 1660 | 08:03:27 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:152.30 Median:149.50 stddev:22.34 (14.9%) stddev-sans-first:23.66 08:03:27 INFO - PROCESS | 1660 | Values: 149.0 150.0 144.0 130.0 150.0 141.0 134.0 149.0 209.0 167.0 08:03:27 INFO - PROCESS | 1660 | 08:03:27 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.20 Median:167.00 stddev:2.66 (1.6%) stddev-sans-first:2.80 08:03:27 INFO - PROCESS | 1660 | Values: 167.0 166.0 168.0 166.0 167.0 159.0 168.0 166.0 168.0 167.0 08:03:27 INFO - PROCESS | 1660 | 08:03:27 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:0.99 (1.5%) stddev-sans-first:0.78 08:03:27 INFO - PROCESS | 1660 | Values: 70.0 68.0 69.0 67.0 69.0 68.0 68.0 67.0 68.0 67.0 08:03:27 INFO - PROCESS | 1660 | -------- Summary: end -------- 08:03:27 INFO - PROCESS | 1660 | 08:03:28 INFO - TEST-INFO | 1660: exit 0 08:03:28 INFO - TEST-OK | kraken | took 60137ms 08:03:28 INFO - SUITE-END | took 1180s 08:03:28 INFO - Completed test suite (00:19:40) 08:03:28 INFO - javascript benchmark 08:03:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3214.164317277508, 3253.9023829285115, 3254.3979363817693, 3268.8365581720936, 3288.736901047915, 5434.809781657643, 5469.699166545838, 5471.945280547194, 5485.451454854512, 5509.2011658309575, 5412.404635490093, 5484.808031718891, 5499.202615620733, 5502.159422822472, 5535.169724541311, 4986.700797952125, 4998.875028124307, 5005.6496045276845, 5050.747462626872, 5155.922661160085, 4992.375953005874, 5005.249212618118, 5046.697198168104, 5127.435982041972, 5136.383633963911, 5020.899582008357, 5068.72122033288, 5069.771860266297, 5074.517920797518, 5076.543111119999, 5055.9241611375855, 5080.212567052113, 5080.720560369178, 5082.059818933509, 5088.821891233826, 4899.779509922062, 5030.094582975063, 5032.345795046621, 5041.621878359138, 5048.444671086178, 5509.449055094498, 5518.696471694056, 5520.337559492847, 5530.778768849241, 5548.500634942875, 5828.475437210672, 5833.358330583633, 5834.095715164156, 5835.416458354173, 5836.241288632493, 4349.391085248068, 5928.79249226275, 5941.584089113764, 5942.435468630473, 6035.124906888521, 5508.9724551377385, 5513.531349835269, 5534.0, 5545.1682247663175, 5557.527610153142, 5143.665661731976, 6210.472109870667, 6222.937770622327, 6231.688415579249, 6233.937660623426, 5604.747786349624, 5637.041702910515, 5664.348599911063, 5672.12082127271, 5716.942830571641, 5628.465295796893, 5988.520918326523, 5989.071693887455, 6001.309849367379, 6005.309389420186, 5944.881102377928, 5953.523718102541, 5954.37479064692, 5957.017092179828, 5991.670458124845, 5796.014677504834, 5844.094165404369, 5851.21008663825, 5971.5222782177325, 6017.939820601826, 4751.4535828379485, 4770.475247722748, 4787.640926930494, 4791.401074865642, 4793.304970779218, 3654.3056819204267, 4275.657947364203, 4302.118065796504, 4305.375720520507, 4330.7401555906745, 5344.91982620261, 5423.647462914898, 5481.232627432163, 5513.42109078549, 5517.972410137923, 5876.324222714357, 5896.734646940898, 5923.4668879800165, 5924.14099955504, 5926.644401335933, 5455.5908306876345, 5457.317835270591, 5503.284573005563, 5521.944780552143, 5557.638753481011, 5205.401378841481, 5207.5313221809465, 5210.426853046162, 5212.4266330703595, 5221.347331583552, 6152.723127459186, 6186.1648677427975, 6198.81403557885, 6227.377262273736, 6250.874982500415, 5850.94149058504, 5915.08316210988, 5927.4665280125, 5950.583459157818, 6029.246344206974, 6239.532035097477, 6240.188775459162, 6243.719032643633, 6251.468625166912, 6252.187215661935, 5828.979928512578, 5872.207252020922, 5887.0580707086665, 5913.970430147821, 5924.763009479572, 5798.681072540882, 5859.736311865891, 5887.852803679771, 6053.757849685963, 6056.454919057306, 5693.345265294379, 5694.202811606461, 5726.599138060295, 5756.280464941882, 5778.971105144447, 4991.675541089818, 5556.721953950695, 5722.284714410699, 5735.512481439125, 5755.942440575541, 5534.833954981357, 5598.412166722435, 5645.604807663424, 5652.3217213934595, 5657.32112146545, 5694.060480020916, 5756.884862302814, 5766.769329226784, 5777.24895763548, 5777.422257774189, 5609.49514543693, 5644.576656750678, 5646.435356464321, 5653.575981801299, 5663.150527420919], "value": 5446.899341260305, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.4823679846554, 512.7205672908267, 524.4755244755244, 528.3501293409107, 544.5697898660059, 23862.761372386292, 37870.43194352084, 38924.610753892455, 39062.60937390625, 39164.412533812014, 34445.65554344462, 38574.0, 39563.80218098913, 39968.0, 40026.199476010464, 9188.264938804896, 9358.57886395114, 9359.251259899193, 9360.251179905625, 9374.10945960136, 9318.86021709675, 9414.52927353633, 9420.952895235514, 9426.905730942672, 9444.102810233016, 8072.3138533224455, 9068.455892646429, 9448.57481413338, 9450.905490945072, 9459.10138536838, 9306.162445379949, 9337.0, 9389.342746007747, 9405.482698451582, 9406.670766523208, 9235.815283694355, 9320.067993200693, 9327.673531426435, 9330.673426430043, 9347.112024357675, 38001.0, 38343.80828095869, 38411.807940960396, 38427.807860960515, 38447.231055379016, 3241.9351612967844, 3304.9504257436156, 3350.430426827445, 3449.275652113059, 3571.4642803579673, 27600.723992760017, 28270.434591308265, 29357.119286421443, 29670.70329296701, 30339.393212135856, 3109.129443755752, 3138.3409484008384, 3149.2756665966726, 3219.114743445548, 3241.8865339713234, 490160.0, 493853.530732344, 493959.0, 494262.52868735784, 494548.0, 32274.0, 56687.43312566821, 57116.428835711115, 57137.71431142818, 57195.0, 33488.83255583706, 34323.97028089161, 34738.131546711025, 34741.0, 34758.13104672403, 13653.863461365458, 13673.794893076612, 14040.0, 14175.574732758034, 14234.359453824603, 11466.08271338291, 11474.770504589862, 11877.990370818578, 11980.28118312904, 12005.339706316236, 7675.002249707502, 7727.072751269883, 7749.651265693057, 7756.6509507072315, 7782.416318776114, 3175.25381535339, 3220.2915358621067, 3220.372027454624, 3230.2570408806105, 3261.8695252190123, 877.2323767608275, 881.7487016200353, 959.6641175588488, 981.7692842182081, 990.2375171118199, 23589.0, 26575.601365979524, 28198.29504262369, 28235.76463530487, 28992.710072899423, 982.8549739553483, 1029.2897900448816, 1034.7102811212872, 1037.7976294622476, 1051.952662130206, 14581.270936453135, 14613.634659133606, 14678.853211467962, 15075.54773356801, 15145.469908553368, 673336.0, 943249.0, 949759.0, 951532.0, 953913.0, 44928.55071449309, 55405.1689224662, 55472.89054218893, 55535.0, 55710.60723481864, 1211.8182272658996, 1255.5417272695584, 1263.7472505498938, 1354.1468874608934, 1375.2985977151525, 23887.283381498582, 27674.0, 29480.705192948655, 30358.544621831134, 31285.687143128278, 51918.96162076813, 52822.47177528175, 52909.735451324035, 52919.0, 53045.469545304055, 593583.0, 600885.0, 602446.0, 603812.0, 604064.0, 39165.608343916196, 39596.604033959295, 40638.796806016966, 40654.39018414785, 40705.79647101746, 43280.78359608182, 43709.0, 43802.34296485491, 44135.77932110447, 44185.779071104436, 36322.09194770152, 36647.26705465929, 36692.81653591715, 36771.44842827306, 37781.622183777814, 36860.89417317485, 36884.446733299555, 37362.8131859339, 37472.81263593664, 37522.2495550082, 29270.853645731637, 30035.399292014474, 35857.282854342244, 36249.81875090607, 36268.27463450769, 31353.216169595944, 32771.34457310888, 33155.83422082874, 33208.66791332152, 33230.003099907044, 24058.0, 24272.27183184507, 24322.0, 24784.0, 24823.379415514755], "value": 18343.36335738433, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.23287452543576, 343.3887679929724, 360.4683092438653, 361.6889475051454, 372.9123655940853, 14762.852371476281, 15298.541043768691, 16895.32418703252, 20033.998300084975, 20080.59838803223, 18490.72263916039, 19784.802151978474, 19799.40601781949, 19834.20663173475, 19871.701924471145, 5620.437956204378, 5833.300003999526, 5860.150278209657, 5890.970545147268, 5895.587308888358, 4083.9795801020955, 4351.891202719941, 5115.897682046357, 6350.555461117724, 6505.967470162666, 6302.527310451712, 6315.842103947392, 6456.677166141698, 6474.935250647504, 6507.51193660475, 6430.48556115512, 6463.48292136628, 6484.902726459107, 6486.545941784077, 6491.22105347359, 5361.758720857571, 5542.91685624716, 5607.775688972436, 5608.775648974077, 5638.295213098363, 24054.917528711074, 24704.876475617508, 24876.3780905477, 24878.875605622037, 25148.11981580636, 2197.9010944507536, 2328.2084091408833, 2361.7874391304695, 2567.4865026994676, 2770.542860428027, 14057.437702491889, 14448.566543003726, 14526.854731452762, 15048.623784405368, 15052.247387630574, 1755.692009452953, 1773.9556511087196, 1812.465322729798, 1904.1241029126618, 1929.3729537900238, 110185.0, 115498.42250788776, 121031.0, 123582.76417235803, 125090.12364814535, 8673.0, 9297.302702297355, 10546.683599492027, 10846.67459976202, 11038.889611103947, 13520.12119212248, 13599.388027538784, 13604.795928061087, 13613.387397567134, 13623.659408514668, 7880.802979925547, 8414.410991230678, 8453.112423195598, 8527.40308178434, 8569.185927336894, 8300.2114799094, 8373.1626837317, 8396.328293736486, 8550.828983420297, 8567.143285671384, 6410.871782564416, 6520.217573891068, 6522.347765223534, 6540.640264785387, 6673.966630166915, 1639.9750156152404, 1767.45208985215, 1838.5383620022114, 1843.6773564626137, 1883.510287325278, 815.6248125862052, 871.1270767849174, 938.2728385501155, 963.4123184857232, 980.4509474694194, 19775.703364449546, 21312.57374852494, 21367.8931605341, 21415.447566268424, 21510.677339839916, 882.4176043811054, 911.5077857956629, 920.4385324951774, 941.204682043672, 956.8660387545749, 10692.679219623267, 11387.544498219979, 11391.544338226544, 11422.600208992812, 11482.827757583644, 582475.0, 590985.0, 591276.0, 608322.0, 611344.0, 72490.0, 89249.55375223083, 115249.0, 116013.35946562044, 116590.0, 936.8969413364524, 973.454865275448, 982.9164521015794, 983.7884854756119, 984.2618036472645, 18803.905980470012, 19226.519337016685, 19407.417777466697, 19456.513587160433, 19498.8050119497, 41420.585794141676, 49273.0, 49894.75052624714, 50095.99808003747, 52648.21027684664, 63460.68269658622, 73781.0, 78036.60981695056, 80807.59596202217, 81010.0, 7840.607969601611, 7854.952013456156, 8001.3598912088055, 8062.475939063942, 8317.251447369767, 8837.55812209374, 10256.948715256376, 12489.625311240678, 12577.310324516302, 12672.239665620093, 10614.681559553226, 10627.36235825853, 10863.67408977732, 11094.611688590861, 11189.608363707557, 9269.72190834276, 10048.49757512136, 10728.624498142528, 10820.0, 11201.383923884265, 10875.966783155587, 10917.290376125526, 10940.234183607072, 11186.161037922026, 11355.37545434976, 7702.345300649507, 7884.44808863397, 7897.1707970662255, 8233.217844304781, 8307.252347288531, 10450.843237351293, 10585.9470702646, 10728.946355268174, 10752.838707419238, 11144.609938652433], "value": 9496.73510144466, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1450.5648305508346, 1451.2163431746858, 1604.7191741445251, 1748.0, 1794.1567463292256, 8006.479578827372, 8412.495250284986, 8427.662893484254, 8431.62057707403, 8446.113158118402, 7335.633218339075, 7608.961955190216, 7635.121960974489, 7939.682412703485, 8254.298384637297, 2270.2281224383746, 2307.065638416436, 2333.6149535326736, 2337.403961989699, 2340.8127349811975, 2310.503241803012, 2352.717673879137, 2377.4888398994212, 2382.65451509531, 2383.7497062808416, 2280.3728974532055, 2316.4903721181313, 2342.02805835578, 2347.530493901218, 2352.7059117610297, 2263.0495192019393, 2293.736220334666, 2323.1984965187066, 2327.5810354136247, 2333.1484008337006, 2315.4674424882205, 2343.308723926446, 2347.2371479269304, 2348.7533808949984, 2351.259353303704, 8081.7171399001345, 8217.753467395987, 8227.012758468962, 8232.50604963704, 8246.917530824734, 4988.87527811804, 5158.045761534128, 5159.2003239497935, 5162.0, 5170.896582068338, 3099.178717639827, 3279.262166012652, 3297.196553507487, 3415.9146021349416, 3426.4517677171784, 988.8566157907063, 1003.8042581696573, 1023.8566600675912, 1026.2508368890751, 1035.5391850626474, 10391.428471434068, 10655.041046305792, 10661.413622250773, 10668.253222274443, 10861.0, 4497.302918047708, 4568.954310456853, 4654.348391225231, 4660.603848672833, 4715.95284047162, 9332.90667093334, 9386.15524602789, 9392.0, 9397.859032114524, 9403.247740180768, 5170.793168273227, 5174.09453345663, 5176.404713457925, 5178.922316165261, 5188.325517682752, 4175.332185100432, 4241.660667146621, 4546.0, 4678.251479763221, 4737.644676649196, 3752.193278445093, 3770.472133901256, 3864.4589757433982, 3889.0, 3889.416587511896, 1225.0934308611563, 1248.7689777391213, 1252.330003448169, 1258.2387655468492, 1274.7641686288066, 787.2757063501592, 856.3491746272878, 884.7920738626418, 905.4160066756905, 913.6071489259682, 5468.250159948858, 5499.7250137492965, 5500.1749737539685, 5508.20131080999, 5616.466435688603, 434.4547592771115, 449.3843434494763, 449.99100017999456, 450.9594136527728, 455.130700362313, 3606.6213047630145, 3629.927401452009, 3631.328204282216, 3637.2725454909123, 3746.3818469952153, 7755.0, 9752.804943901083, 9863.309568330147, 9864.704058878246, 9936.254780891462, 9794.363366381162, 9812.607495700093, 9814.803703925882, 9818.803623927624, 9820.0, 7344.339009489172, 7535.472516923763, 7581.128170260491, 7734.187910269453, 7739.0, 4567.1779079765965, 5158.664686795346, 5411.269478620493, 5465.535429488538, 5584.078627026495, 8981.640734370552, 9117.270618350649, 9184.678536251466, 9270.258379329503, 9279.860802087838, 9287.72136835896, 9325.347225694137, 9348.485833279236, 9354.579043942902, 9436.669716559887, 7007.649617519001, 7038.01467794499, 7042.401395881203, 7104.076470059066, 7125.429965602636, 7606.706859833731, 7688.038995125609, 7697.6151192441275, 7704.422168337285, 7718.53688778675, 6808.353206445379, 6911.343422374866, 6913.1358580177475, 7003.5797852129035, 7061.505694601328, 6773.491988101011, 6817.659117044227, 6841.760538381132, 6869.519133660596, 6883.552569082994, 5295.602829787705, 6384.106225128578, 6453.16108905858, 6454.870902581828, 6476.676166191577, 4664.743439110882, 4667.906641867075, 4707.388039554836, 4739.0, 4836.347093142522, 4552.817887284472, 4742.810287588458, 4831.323614693875, 4838.854834354975, 4858.7570621469495], "value": 4262.199429630271, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.13230968642506, 295.10435827264246, 303.532559857819, 309.9535069739539, 310.42726170215946, 5004.924926126111, 5160.561352285055, 5175.0, 5184.740762961856, 5216.487218706576, 3933.350997085485, 4452.438049560347, 4860.8055677772845, 5184.403793563732, 5216.5826733861295, 4000.5799391063956, 4003.8198281077275, 4028.63742263197, 4035.4955630546033, 4038.2731108400476, 3128.499440089586, 3545.574531056264, 3925.7437619961624, 4038.4144299076615, 4040.5353384360883, 3598.9280214395694, 3915.318007165087, 3936.8505195843354, 3960.980195099035, 3962.9405558916637, 3590.850927703123, 3595.712343012579, 3617.94573081404, 3932.3315036443732, 3940.7241493095494, 2849.843258620775, 3248.658890816454, 3399.5920489541413, 3438.2951494943477, 3457.3949558827103, 4689.0, 5096.974515127437, 5119.948800511985, 5134.409542902539, 5142.871428214287, 3616.8553257869653, 4532.4334458192725, 4536.274196128604, 4542.318652202163, 4542.841000564964, 5141.76862041209, 5358.115910874701, 5507.972460137714, 5517.317218248473, 5528.530074943635, 3185.8566364513654, 3734.402495600691, 3769.6230376962085, 3778.6761141897537, 3805.0297174220673, 4794.856154315376, 5618.410066942994, 5675.31896172462, 5698.658080515141, 5729.226554415142, 3669.486271921933, 3797.848086076526, 3821.178446633987, 3821.7515861468914, 3826.7129965252716, 3777.99883030997, 3832.7125465590193, 3848.7883166425554, 3859.4017927221325, 3874.4769456123627, 3894.805259737002, 4449.3993310902615, 4480.910381792346, 4481.484629267611, 4486.75050191277, 4368.541303163186, 4765.594924431392, 5473.143736202305, 5491.007400966483, 5492.395836457987, 1056.2131212246925, 1072.7318170457386, 1162.9940101811872, 1239.5971309324505, 1242.944067516964, 828.3662997806682, 843.333766324609, 853.8249658819927, 854.43607219235, 855.8189698216421, 4152.584741525884, 4161.791910404529, 4183.184279065553, 4281.422008028939, 4878.95121048792, 4514.887127821765, 4856.73287969158, 5287.735613219324, 5299.006061575197, 5301.787928482818, 4271.124419493996, 4663.95061111254, 4811.711297322172, 4835.138471688355, 4843.830465933675, 2560.4879024195234, 2626.1858823764696, 2764.751172394494, 2788.567771995344, 2803.971960280371, 4662.813487460531, 4702.741349225826, 5492.457364999553, 5503.0, 5509.173623956439, 4644.210484217691, 5290.0, 5399.464449862135, 5413.566914646819, 5451.182322651634, 5191.480851914778, 5249.97625463031, 5528.391876893538, 5907.518842086334, 5922.585419020627, 4495.887602809956, 5675.055836193806, 5702.5764050279295, 5715.942550628147, 5719.685417302088, 4183.058811767328, 4629.745364005012, 4848.903021939471, 5083.212102124176, 5679.460451257124, 4739.824317707214, 5142.614303927146, 5549.944500554942, 5853.678047707417, 5923.585349025527, 3638.072291565634, 3662.50556174913, 3808.466814645896, 3837.76973381598, 3847.3651847445976, 4384.344195987268, 5201.063808514353, 5609.88780224385, 5647.604667673223, 5727.914081288701, 5511.724413779375, 5516.393196748435, 5520.806771762969, 5542.63972841764, 5547.362053363915, 5061.013102445135, 5513.421090785409, 5522.641028333145, 5546.4453554644215, 5579.972100139474, 4208.305629571087, 4639.536046395334, 5415.756290966995, 5435.565154787529, 5453.509184173444, 4610.838620648261, 4728.361671174347, 5260.368755749335, 5510.91733623988, 5547.639403438763, 4503.437070366204, 5418.241446197457, 5425.593080519056, 5431.23962645222, 5446.618736688552], "value": 3904.3218167441682, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.6378555579987, 681.8806708825956, 712.1774350625027, 721.6968873073308, 778.0740918307214, 13697.520586779465, 14390.280485975713, 14438.5668429947, 14445.566633001026, 14451.13293202406, 12702.491900324, 12849.357532123404, 12850.293233872133, 12856.100072994894, 12857.678558036054, 791.6239786101598, 808.975730728079, 814.8044469327349, 824.8556502612049, 828.362161135925, 819.0580832043139, 819.4550623835142, 820.2125959079291, 823.8105235795771, 824.3075816314295, 856.4989481153533, 859.0, 859.3597769661611, 859.3683642522741, 861.2894362151219, 847.3348421489133, 853.4708480741917, 854.6111519258784, 854.9615267312955, 856.4818284937647, 632.7184402940693, 633.0946746152999, 633.2527617411453, 633.9524535659798, 636.7262077306756, 13768.655783605389, 14024.649383765487, 14043.64890877726, 14079.929600351932, 14099.78850317246, 12880.227186368847, 13103.934480327633, 13129.277889716062, 13131.212127272394, 13318.533851315255, 10548.156147508182, 11024.393658348788, 11163.051140653055, 11193.440327983568, 11636.0, 3500.282442099389, 3517.9120521987156, 3540.274243780019, 3574.0, 3628.2924829658227, 66327.66836165884, 82629.0, 83402.58298708528, 85270.0, 86391.13608863894, 9967.302288839712, 10080.798384032425, 10301.845472317922, 10337.276390652582, 10542.789144217226, 18811.15349809262, 19105.0, 19121.330753423565, 19141.80858191428, 19155.712664310046, 6246.28286695289, 6318.862604731193, 7118.572885626775, 7404.037475128306, 7463.440241981873, 3641.7997010164695, 3667.211549516867, 4164.229617520768, 4235.449391579136, 4237.665135482313, 2967.925801854971, 3313.7017668409476, 3421.4183588789965, 3443.4146195146886, 3708.313961917054, 688.8656711941123, 692.5221597098086, 692.9757458488929, 696.8745326753382, 707.9539829911039, 558.3746204251264, 559.7481133489946, 581.7818318130701, 625.7090452939404, 642.7814543055383, 8882.467051976902, 9597.712068637951, 9629.951850240705, 9897.554610042565, 10015.349002314826, 508.9745512724349, 544.2271973797217, 589.7876764364826, 666.4768156996735, 674.7604600366898, 4134.586541345901, 4379.321205213197, 4402.471703395613, 4419.40338054365, 4499.797509112098, 62182.0, 80340.59829700814, 97758.53362199572, 98041.50979245058, 99874.0, 56076.0, 61243.6937815317, 65610.34389656138, 67017.32982670111, 84095.0, 71930.64034679793, 75153.62423187958, 76322.6183869077, 77223.0, 82151.0, 9045.0, 9509.476978765957, 9546.056449093077, 9547.570359333708, 9631.9036809631, 41296.76109716713, 42357.57642423536, 45222.54777452315, 49738.50261497339, 51874.74062629814, 51117.72205694739, 56546.717266413405, 69537.2615684612, 72215.63892180506, 72262.0, 11846.229995050295, 11899.345535995604, 11912.642620721392, 11960.880391195977, 12245.57140500114, 13039.413226405024, 13432.992525560818, 13464.730705385642, 13702.0, 13748.793768093687, 12120.212186207867, 12802.16785908913, 12809.551665691655, 12897.935510322388, 13109.344532773133, 12157.574484892986, 12459.93770031144, 12484.750304993668, 12596.937015315232, 13066.934665326613, 12007.879921200676, 12138.150329476852, 12996.350182490649, 13119.147255428366, 13296.0, 10210.132138768287, 10268.229882758673, 10879.836802448128, 11107.666769996913, 11315.20793544444, 8428.243741897026, 9025.729228123168, 9988.400695958266, 10115.190784737057, 10138.543765530421], "value": 6936.236330928788, "unit": "score"}], "name": "dromaeo_css", "value": 6917.125821130591, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0, 113.0, 114.0, 114.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 111.0, 112.0, 144.0, 111.0, 109.0, 110.0, 115.0, 171.0, 114.0], "value": 123.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 182.0, 186.0, 186.0, 186.0, 184.0, 185.0, 186.0, 220.0, 264.0], "value": 196.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 62.0, 88.0, 61.0, 59.0, 60.0, 59.0, 82.0, 58.0], "value": 67.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 72.0, 95.0, 69.0, 68.0, 70.0, 92.0, 67.0, 68.0, 93.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 89.0, 86.0, 89.0, 86.0, 89.0, 86.0, 90.0, 86.0], "value": 87.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 101.0, 96.0, 90.0, 131.0, 146.0, 94.0, 94.0, 94.0], "value": 103.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 79.0, 80.0, 83.0, 84.0, 84.0, 83.0, 82.0, 84.0], "value": 82.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 82.0, 86.0, 87.0, 59.0, 59.0, 58.0, 58.0, 59.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 70.0, 70.0, 79.0, 73.0, 69.0, 69.0, 69.0, 70.0, 72.0], "value": 70.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 82.0, 98.0, 100.0, 100.0, 95.0, 79.0, 87.0, 75.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 144.0, 130.0, 150.0, 141.0, 134.0, 149.0, 209.0, 167.0], "value": 152.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 168.0, 166.0, 167.0, 159.0, 168.0, 166.0, 168.0, 167.0], "value": 166.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 69.0, 67.0, 69.0, 68.0, 68.0, 67.0, 68.0, 67.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1462.0, "alertThreshold": 2.0}]} 08:03:28 INFO - Return code: 0 08:03:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:03:28 INFO - # TBPL SUCCESS # 08:03:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:03:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:03:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:03:28 INFO - 2016-12-27 08:03:28.304 screenresolution[1664:16506] starting screenresolution argv=screenresolution get 08:03:28 INFO - 2016-12-27 08:03:28.307 screenresolution[1664:16506] Display 0: 1600x1200x32@60 08:03:28 INFO - 2016-12-27 08:03:28.313 screenresolution[1665:16510] starting screenresolution argv=screenresolution list 08:03:28 INFO - Available Modes on Display 0 08:03:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:03:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:03:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:03:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:03:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:03:28 INFO - Intel Iris: 08:03:28 INFO - Chipset Model: Intel Iris 08:03:28 INFO - Type: GPU 08:03:28 INFO - Bus: Built-In 08:03:28 INFO - VRAM (Dynamic, Max): 1536 MB 08:03:28 INFO - Vendor: Intel (0x8086) 08:03:28 INFO - Device ID: 0x0a2e 08:03:28 INFO - Revision ID: 0x0009 08:03:28 INFO - Displays: 08:03:28 INFO - Display: 08:03:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:03:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:03:28 INFO - Display Serial Number: 1600x1200 60 08:03:28 INFO - Main Display: Yes 08:03:28 INFO - Mirror: Off 08:03:28 INFO - Online: Yes 08:03:28 INFO - Rotation: Supported 08:03:28 INFO - Return code: 0 08:03:28 INFO - Running post-action listener: _resource_record_post_action 08:03:28 INFO - [mozharness: 2016-12-27 16:03:28.559387Z] Finished run-tests step (success) 08:03:28 INFO - Running post-run listener: _resource_record_post_run 08:03:28 INFO - Total resource usage - Wall time: 1213s; CPU: 53.0%; Read bytes: 33483776; Write bytes: 658679296; Read time: 309; Write time: 2114 08:03:28 INFO - TinderboxPrint: CPU usage
53.4% 08:03:28 INFO - TinderboxPrint: I/O read bytes / time
33,483,776 / 309 08:03:28 INFO - TinderboxPrint: I/O write bytes / time
658,679,296 / 2,114 08:03:28 INFO - TinderboxPrint: CPU idle
2,262.6 (46.6%) 08:03:28 INFO - TinderboxPrint: CPU system
974.8 (20.1%) 08:03:28 INFO - TinderboxPrint: CPU user
1,616.2 (33.3%) 08:03:28 INFO - TinderboxPrint: Swap in / out
378,134,528 / 0 08:03:28 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 349983232; Write bytes: 351750144; Read time: 27306; Write time: 641 08:03:28 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 29129728; Write bytes: 305430016; Read time: 275; Write time: 1466 08:03:29 INFO - Running post-run listener: _upload_blobber_files 08:03:29 INFO - Blob upload gear active. 08:03:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:03:29 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:03:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:03:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:03:29 INFO - (blobuploader) - INFO - Open directory for files ... 08:03:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:03:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:03:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:03:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:03:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:03:30 INFO - (blobuploader) - INFO - Done attempting. 08:03:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:03:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:03:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:03:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:03:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:03:31 INFO - (blobuploader) - INFO - Done attempting. 08:03:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:03:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:03:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:03:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:03:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:03:33 INFO - (blobuploader) - INFO - Done attempting. 08:03:33 INFO - (blobuploader) - INFO - Iteration through files over. 08:03:33 INFO - Return code: 0 08:03:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:03:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:03:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22c3a2592a057fdbde07e0d7c4494d8b7b7ce5e5d51dc99c542935568ba93b1d3aa8df6933cca3994a6c18904c1967de3d2eb1ade3995aadd4826cc550f90695", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93be5518f967d72b8996b111bc109d1f834465e2c7a191e291da642d8ec1404080eeffcf211c578c88d99f6d077d196185dc354e87e06333c1d888b994659da9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/63a0e46c56387c4631d5c9e1d1c0c72fd2bd9f4455597cb208ac4cb1c11a430dfc3abaa720be5065ac1aa77672f9a791d2d122376c8eee79bf1cc76e51ce0ee7"} 08:03:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:03:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:03:33 INFO - Contents: 08:03:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22c3a2592a057fdbde07e0d7c4494d8b7b7ce5e5d51dc99c542935568ba93b1d3aa8df6933cca3994a6c18904c1967de3d2eb1ade3995aadd4826cc550f90695", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93be5518f967d72b8996b111bc109d1f834465e2c7a191e291da642d8ec1404080eeffcf211c578c88d99f6d077d196185dc354e87e06333c1d888b994659da9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/63a0e46c56387c4631d5c9e1d1c0c72fd2bd9f4455597cb208ac4cb1c11a430dfc3abaa720be5065ac1aa77672f9a791d2d122376c8eee79bf1cc76e51ce0ee7"} 08:03:33 INFO - Running post-run listener: copy_logs_to_upload_dir 08:03:33 INFO - Copying logs to upload dir... 08:03:33 INFO - mkdir: /builds/slave/test/build/upload/logs 08:03:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.814207 ========= master_lag: 0.82 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-12-27 08:03:34.456403) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-27 08:03:34.460120) ========= 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.9Ov0UW2o6U/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.3UDZXC90MU/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22c3a2592a057fdbde07e0d7c4494d8b7b7ce5e5d51dc99c542935568ba93b1d3aa8df6933cca3994a6c18904c1967de3d2eb1ade3995aadd4826cc550f90695", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93be5518f967d72b8996b111bc109d1f834465e2c7a191e291da642d8ec1404080eeffcf211c578c88d99f6d077d196185dc354e87e06333c1d888b994659da9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/63a0e46c56387c4631d5c9e1d1c0c72fd2bd9f4455597cb208ac4cb1c11a430dfc3abaa720be5065ac1aa77672f9a791d2d122376c8eee79bf1cc76e51ce0ee7"} build_url:https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011314 build_url: 'https://queue.taskcluster.net/v1/task/MnJlQYT2QQOsPLsQm6cBiQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22c3a2592a057fdbde07e0d7c4494d8b7b7ce5e5d51dc99c542935568ba93b1d3aa8df6933cca3994a6c18904c1967de3d2eb1ade3995aadd4826cc550f90695", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93be5518f967d72b8996b111bc109d1f834465e2c7a191e291da642d8ec1404080eeffcf211c578c88d99f6d077d196185dc354e87e06333c1d888b994659da9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/63a0e46c56387c4631d5c9e1d1c0c72fd2bd9f4455597cb208ac4cb1c11a430dfc3abaa720be5065ac1aa77672f9a791d2d122376c8eee79bf1cc76e51ce0ee7"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-27 08:03:34.497950) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 08:03:34.498264) ========= 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.9Ov0UW2o6U/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.3UDZXC90MU/Listeners TMPDIR=/var/folders/z3/t5k6xjnj1b7c750r159xpw7800000w/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.005172 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-27 08:03:34.546644) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-27 08:03:34.546961) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-27 08:03:34.547286) ========= ========= Total master_lag: 0.99 =========