builder: larch_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0291 starttime: 1479252309.87 results: success (0) buildid: 20161115120248 builduid: f1e14276ff5f488e92138bc7fb7afb08 revision: 8616872c1e2299bd55ae435654de757f3175c494 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-15 15:25:09.868062) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-15 15:25:09.868421) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2016-11-15 15:25:09.868688) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2016-11-15 15:25:13.333996) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 15:25:13.334306) ========= 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.bZXyYtAfpJ/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.v09wVbEbJV/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-15 15:25:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.71M=0.001s 2016-11-15 15:25:13 (8.71 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134921 ========= master_lag: 0.36 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 15:25:13.831153) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 15:25:13.831499) ========= 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.bZXyYtAfpJ/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.v09wVbEbJV/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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.019683 ========= master_lag: 0.15 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 15:25:13.998781) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-15 15:25:13.999175) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 8616872c1e2299bd55ae435654de757f3175c494 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 8616872c1e2299bd55ae435654de757f3175c494 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bZXyYtAfpJ/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.v09wVbEbJV/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-15 15:25:14,210 truncating revision to first 12 chars 2016-11-15 15:25:14,211 Setting DEBUG logging. 2016-11-15 15:25:14,211 attempt 1/10 2016-11-15 15:25:14,211 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/8616872c1e22?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-15 15:25:15,711 unpacking tar archive at: larch-8616872c1e22/testing/mozharness/ program finished with exit code 0 elapsedTime=1.759109 ========= master_lag: 0.15 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-15 15:25:15.911592) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-15 15:25:15.911905) ========= script_repo_revision: 8616872c1e2299bd55ae435654de757f3175c494 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-15 15:25:15.912329) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-15 15:25:15.912598) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-15 15:25:15.931282) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-11-15 15:25:15.931681) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 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', 'Larch', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bZXyYtAfpJ/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.v09wVbEbJV/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 15:25:16 INFO - MultiFileLogger online at 20161115 15:25:16 in /builds/slave/test 15:25:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 15:25:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:25:16 INFO - {'append_to_log': False, 15:25:16 INFO - 'base_work_dir': '/builds/slave/test', 15:25:16 INFO - 'blob_upload_branch': 'Larch', 15:25:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:25:16 INFO - 'branch': 'Larch', 15:25:16 INFO - 'buildbot_json_path': 'buildprops.json', 15:25:16 INFO - 'config_files': ('talos/mac_config.py',), 15:25:16 INFO - 'default_actions': ('clobber', 15:25:16 INFO - 'read-buildbot-config', 15:25:16 INFO - 'download-and-extract', 15:25:16 INFO - 'populate-webroot', 15:25:16 INFO - 'create-virtualenv', 15:25:16 INFO - 'install', 15:25:16 INFO - 'run-tests'), 15:25:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:25:16 INFO - 'download_minidump_stackwalk': True, 15:25:16 INFO - 'download_symbols': 'ondemand', 15:25:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:25:16 INFO - 'tooltool.py': '/tools/tooltool.py', 15:25:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:25:16 INFO - '/tools/misc-python/virtualenv.py')}, 15:25:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:25:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:25:16 INFO - 'installer_path': 'installer.exe', 15:25:16 INFO - 'log_level': 'info', 15:25:16 INFO - 'log_name': 'talos', 15:25:16 INFO - 'log_to_console': True, 15:25:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:25:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:25:16 INFO - 'opt_config_files': (), 15:25:16 INFO - 'pip_index': False, 15:25:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:25:16 INFO - 'cmd': ('bash', 15:25:16 INFO - '-c', 15:25:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:25:16 INFO - 'enabled': True, 15:25:16 INFO - 'halt_on_failure': False, 15:25:16 INFO - 'name': 'check_screen_resolution'},), 15:25:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:25:16 INFO - 'cmd': ('bash', 15:25:16 INFO - '-c', 15:25:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:25:16 INFO - 'enabled': True, 15:25:16 INFO - 'halt_on_failure': False, 15:25:16 INFO - 'name': 'check_screen_resolution'},), 15:25:16 INFO - 'run_cmd_checks_enabled': True, 15:25:16 INFO - 'sps_profile': False, 15:25:16 INFO - 'sps_profile_interval': 0, 15:25:16 INFO - 'suite': 'dromaeojs', 15:25:16 INFO - 'system_bits': '32', 15:25:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:25:16 INFO - 'title': 't-yosemite-r7-0291', 15:25:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:25:16 INFO - 'use_talos_json': True, 15:25:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:25:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:25:16 INFO - 'work_dir': 'build'} 15:25:16 INFO - [mozharness: 2016-11-15 23:25:16.132538Z] Running clobber step. 15:25:16 INFO - Running pre-action listener: _resource_record_pre_action 15:25:16 INFO - Running main action method: clobber 15:25:16 INFO - rmtree: /builds/slave/test/build 15:25:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:25:17 INFO - Running post-action listener: _resource_record_post_action 15:25:17 INFO - [mozharness: 2016-11-15 23:25:17.636499Z] Finished clobber step (success) 15:25:17 INFO - [mozharness: 2016-11-15 23:25:17.636580Z] Running read-buildbot-config step. 15:25:17 INFO - Running pre-action listener: _resource_record_pre_action 15:25:17 INFO - Running main action method: read_buildbot_config 15:25:17 INFO - Using buildbot properties: 15:25:17 INFO - { 15:25:17 INFO - "project": "", 15:25:17 INFO - "product": "firefox", 15:25:17 INFO - "script_repo_revision": "production", 15:25:17 INFO - "builddir": "larch_yosemite_r7_test-dromaeojs", 15:25:17 INFO - "repository": "", 15:25:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 larch talos dromaeojs", 15:25:17 INFO - "buildid": "20161115120248", 15:25:17 INFO - "pgo_build": "False", 15:25:17 INFO - "basedir": "/builds/slave/test", 15:25:17 INFO - "buildnumber": 1, 15:25:17 INFO - "slavename": "t-yosemite-r7-0291", 15:25:17 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 15:25:17 INFO - "platform": "yosemite_r7", 15:25:17 INFO - "scheduler": "tests-larch-macosx64-talos", 15:25:17 INFO - "branch": "larch", 15:25:17 INFO - "repo_path": "projects/larch", 15:25:17 INFO - "revision": "8616872c1e2299bd55ae435654de757f3175c494", 15:25:17 INFO - "stage_platform": "macosx64", 15:25:17 INFO - "builduid": "f1e14276ff5f488e92138bc7fb7afb08", 15:25:17 INFO - "slavebuilddir": "test" 15:25:17 INFO - } 15:25:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/dvdu9aQ6R0uWGZZ32z5uqg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 15:25:17 INFO - Running post-action listener: _resource_record_post_action 15:25:17 INFO - [mozharness: 2016-11-15 23:25:17.639737Z] Finished read-buildbot-config step (success) 15:25:17 INFO - [mozharness: 2016-11-15 23:25:17.639867Z] Running download-and-extract step. 15:25:17 INFO - Running pre-action listener: _resource_record_pre_action 15:25:17 INFO - Running main action method: download_and_extract 15:25:17 INFO - mkdir: /builds/slave/test/build/tests 15:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:17 INFO - trying https://queue.taskcluster.net/v1/task/dvdu9aQ6R0uWGZZ32z5uqg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 15:25:17 INFO - Downloading https://queue.taskcluster.net/v1/task/dvdu9aQ6R0uWGZZ32z5uqg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 15:25:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dvdu9aQ6R0uWGZZ32z5uqg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 15:25:18 INFO - Downloaded 1199 bytes. 15:25:18 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 15:25:18 INFO - Using the following test package requirements: 15:25:18 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 15:25:18 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:25:18 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 15:25:18 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:25:18 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 15:25:18 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:25:18 INFO - u'jsshell-mac.zip'], 15:25:18 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:25:18 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 15:25:18 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 15:25:18 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:25:18 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 15:25:18 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:25:18 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 15:25:18 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:25:18 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 15:25:18 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:25:18 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 15:25:18 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:25:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dvdu9aQ6R0uWGZZ32z5uqg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 15:25:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dvdu9aQ6R0uWGZZ32z5uqg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:25:18 INFO - Fetch https://queue.taskcluster.net/v1/task/dvdu9aQ6R0uWGZZ32z5uqg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 15:25:19 INFO - Http code: 200 15:25:19 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 15:25:19 INFO - x-amz-cf-id: iWeCLRpzgRXOzQQnKAzc0AWERREoz0glAP6Gnxni_cc6LXaKxUDYzA== 15:25:19 INFO - x-amz-version-id: tvSGG_W8ng9tQJpiwjnXM4UHVDDm65UU 15:25:19 INFO - Expected file size: 16328517 15:25:19 INFO - Obtained file size: 16328517 15:25:26 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:25:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dvdu9aQ6R0uWGZZ32z5uqg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 15:25:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dvdu9aQ6R0uWGZZ32z5uqg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:25:26 INFO - Fetch https://queue.taskcluster.net/v1/task/dvdu9aQ6R0uWGZZ32z5uqg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 15:25:26 INFO - Http code: 200 15:25:26 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 15:25:26 INFO - x-amz-cf-id: 1rZ3yPLh1LhedmHpNZJWeIXnDjYfNDJMdPEnum4LlVsidCe1cUSxyQ== 15:25:26 INFO - x-amz-version-id: tvSGG_W8ng9tQJpiwjnXM4UHVDDm65UU 15:25:27 INFO - Expected file size: 16328517 15:25:27 INFO - Obtained file size: 16328517 15:25:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dvdu9aQ6R0uWGZZ32z5uqg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 15:25:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dvdu9aQ6R0uWGZZ32z5uqg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:25:33 INFO - Fetch https://queue.taskcluster.net/v1/task/dvdu9aQ6R0uWGZZ32z5uqg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 15:25:33 INFO - Http code: 200 15:25:33 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 15:25:33 INFO - x-amz-cf-id: nqWlvklX97arqo3TMXl409RLncGtKWNZLmsxov3_XbRl4WHxH7ipCA== 15:25:33 INFO - x-amz-version-id: vEMWpkvOEdRGsHHNtym3LVTrz7pXk2XJ 15:25:34 INFO - Expected file size: 14409038 15:25:34 INFO - Obtained file size: 14409038 15:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:34 INFO - trying https://queue.taskcluster.net/v1/task/dvdu9aQ6R0uWGZZ32z5uqg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:25:34 INFO - Downloading https://queue.taskcluster.net/v1/task/dvdu9aQ6R0uWGZZ32z5uqg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 15:25:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dvdu9aQ6R0uWGZZ32z5uqg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 15:25:37 INFO - Downloaded 110984883 bytes. 15:25:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dvdu9aQ6R0uWGZZ32z5uqg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:25:37 INFO - mkdir: /builds/slave/test/properties 15:25:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:25:37 INFO - Writing to file /builds/slave/test/properties/build_url 15:25:37 INFO - Contents: 15:25:37 INFO - build_url:https://queue.taskcluster.net/v1/task/dvdu9aQ6R0uWGZZ32z5uqg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:25:37 INFO - Running post-action listener: _resource_record_post_action 15:25:37 INFO - Running post-action listener: set_extra_try_arguments 15:25:37 INFO - [mozharness: 2016-11-15 23:25:37.805868Z] Finished download-and-extract step (success) 15:25:37 INFO - [mozharness: 2016-11-15 23:25:37.806004Z] Running populate-webroot step. 15:25:37 INFO - Running pre-action listener: _resource_record_pre_action 15:25:37 INFO - Running main action method: populate_webroot 15:25:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:25:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:25:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:25:37 INFO - '--tppagecycles', 15:25:37 INFO - '7'], 15:25:37 INFO - 'tests': ['tsvgm']}}, 15:25:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:25:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:25:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:25:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:25:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:25:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:25:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:25:37 INFO - 'talos_options': ['--disable-e10s'], 15:25:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:25:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:25:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:25:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:25:37 INFO - 'talos_options': ['--disable-e10s'], 15:25:37 INFO - 'tests': ['damp', 'tps']}, 15:25:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:25:37 INFO - 'tests': ['damp', 'tps']}, 15:25:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:25:37 INFO - 'tests': ['dromaeo_dom']}, 15:25:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:25:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:25:37 INFO - 'tests': ['basic_compositor_video']}, 15:25:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:25:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:25:37 INFO - 'tests': ['a11yr', 15:25:37 INFO - 'ts_paint', 15:25:37 INFO - 'tpaint', 15:25:37 INFO - 'sessionrestore', 15:25:37 INFO - 'sessionrestore_no_auto_restore', 15:25:37 INFO - 'tabpaint']}, 15:25:37 INFO - 'other-e10s': {'tests': ['a11yr', 15:25:37 INFO - 'ts_paint', 15:25:37 INFO - 'tpaint', 15:25:37 INFO - 'sessionrestore', 15:25:37 INFO - 'sessionrestore_no_auto_restore', 15:25:37 INFO - 'tabpaint']}, 15:25:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:25:37 INFO - 'ts_paint', 15:25:37 INFO - 'tpaint', 15:25:37 INFO - 'sessionrestore', 15:25:37 INFO - 'sessionrestore_no_auto_restore', 15:25:37 INFO - 'tabpaint']}, 15:25:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:25:37 INFO - 'ts_paint', 15:25:37 INFO - 'tpaint', 15:25:37 INFO - 'sessionrestore', 15:25:37 INFO - 'sessionrestore_no_auto_restore', 15:25:37 INFO - 'tabpaint']}, 15:25:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:25:37 INFO - 'tests': ['a11yr', 15:25:37 INFO - 'ts_paint', 15:25:37 INFO - 'tpaint', 15:25:37 INFO - 'sessionrestore', 15:25:37 INFO - 'sessionrestore_no_auto_restore', 15:25:37 INFO - 'tabpaint']}, 15:25:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:25:37 INFO - 'tests': ['a11yr', 15:25:37 INFO - 'ts_paint', 15:25:37 INFO - 'tpaint', 15:25:37 INFO - 'sessionrestore', 15:25:37 INFO - 'sessionrestore_no_auto_restore', 15:25:37 INFO - 'tabpaint']}, 15:25:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:25:37 INFO - 'tests': ['tsvgx', 15:25:37 INFO - 'tsvgr_opacity', 15:25:37 INFO - 'tart', 15:25:37 INFO - 'tscrollx', 15:25:37 INFO - 'cart']}, 15:25:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:25:37 INFO - 'tsvgr_opacity', 15:25:37 INFO - 'tart', 15:25:37 INFO - 'tscrollx', 15:25:37 INFO - 'cart']}, 15:25:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:25:37 INFO - 'talos_options': ['--disable-e10s'], 15:25:37 INFO - 'tests': ['tp5o']}, 15:25:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:25:37 INFO - 'tests': ['tp5o']}, 15:25:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:25:37 INFO - 'talos_options': ['--disable-e10s', 15:25:37 INFO - '--xperf_path', 15:25:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:25:37 INFO - 'tests': ['tp5n']}, 15:25:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:25:37 INFO - 'talos_options': ['--xperf_path', 15:25:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:25:37 INFO - 'tests': ['tp5n']}}, 15:25:37 INFO - 'talos.zip': {'path': '', 15:25:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:25:37 INFO - Running post-action listener: _resource_record_post_action 15:25:37 INFO - [mozharness: 2016-11-15 23:25:37.824503Z] Finished populate-webroot step (success) 15:25:37 INFO - [mozharness: 2016-11-15 23:25:37.824641Z] Running create-virtualenv step. 15:25:37 INFO - Running pre-action listener: _resource_record_pre_action 15:25:37 INFO - Running main action method: create_virtualenv 15:25:37 INFO - Creating virtualenv /builds/slave/test/build/venv 15:25:37 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 15:25:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:25:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:25:37 INFO - Using real prefix '/tools/python27' 15:25:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:25:38 INFO - Installing distribute.............................................................................................................................................................................................done. 15:25:41 INFO - Installing pip.................done. 15:25:41 INFO - Return code: 0 15:25:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:25:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:25:41 INFO - Reading from file tmpfile_stdout 15:25:41 INFO - Output received: 15:25:41 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) 15:25:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:25:41 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')]} 15:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:41 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')]} 15:25:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:41 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 0x109921490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109897570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb2248b2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109735d30>, '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 0x10955bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10972db20>, '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.bZXyYtAfpJ/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.v09wVbEbJV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 15:25:41 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 15:25:41 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 15:25:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bZXyYtAfpJ/Render', 15:25:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:25:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:25:41 INFO - 'HOME': '/Users/cltbld', 15:25:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:25:41 INFO - 'LOGNAME': 'cltbld', 15:25:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:41 INFO - 'MOZ_NO_REMOTE': '1', 15:25:41 INFO - 'NO_EM_RESTART': '1', 15:25:41 INFO - 'PAGER': '/bin/cat', 15:25:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:25:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:41 INFO - 'PWD': '/builds/slave/test', 15:25:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:25:41 INFO - 'SHELL': '/bin/bash', 15:25:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v09wVbEbJV/Listeners', 15:25:41 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 15:25:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:25:41 INFO - 'USER': 'cltbld', 15:25:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:25:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:25:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:41 INFO - 'XPC_FLAGS': '0x0', 15:25:41 INFO - 'XPC_SERVICE_NAME': '0', 15:25:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:25:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:42 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 15:25:42 INFO - Cleaning up... 15:25:42 INFO - Return code: 0 15:25:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:25:42 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')]} 15:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:42 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')]} 15:25:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:42 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 0x109921490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109897570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb2248b2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109735d30>, '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 0x10955bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10972db20>, '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.bZXyYtAfpJ/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.v09wVbEbJV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 15:25:42 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 15:25:42 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 15:25:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bZXyYtAfpJ/Render', 15:25:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:25:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:25:42 INFO - 'HOME': '/Users/cltbld', 15:25:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:25:42 INFO - 'LOGNAME': 'cltbld', 15:25:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:42 INFO - 'MOZ_NO_REMOTE': '1', 15:25:42 INFO - 'NO_EM_RESTART': '1', 15:25:42 INFO - 'PAGER': '/bin/cat', 15:25:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:25:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:42 INFO - 'PWD': '/builds/slave/test', 15:25:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:25:42 INFO - 'SHELL': '/bin/bash', 15:25:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v09wVbEbJV/Listeners', 15:25:42 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 15:25:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:25:42 INFO - 'USER': 'cltbld', 15:25:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:25:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:25:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:42 INFO - 'XPC_FLAGS': '0x0', 15:25:42 INFO - 'XPC_SERVICE_NAME': '0', 15:25:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:25:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:42 INFO - Downloading/unpacking psutil>=3.1.1 15:25:42 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 15:25:42 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 15:25:42 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 15:25:42 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 15:25:42 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 15:25:42 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 15:25:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:25:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:25:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:25:45 INFO - Installing collected packages: psutil 15:25:45 INFO - Running setup.py install for psutil 15:25:46 INFO - building 'psutil._psutil_osx' extension 15:25:46 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 15:25:46 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 15:25:46 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 15:25:46 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 15:25:46 INFO - building 'psutil._psutil_posix' extension 15:25:46 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 15:25:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:25:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:25:46 INFO - ^ 15:25:46 INFO - 1 warning generated. 15:25:46 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 15:25:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:25:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:25:46 INFO - Successfully installed psutil 15:25:46 INFO - Cleaning up... 15:25:46 INFO - Return code: 0 15:25:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:25: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')]} 15:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25: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')]} 15:25:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109921490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109897570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb2248b2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109735d30>, '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 0x10955bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10972db20>, '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.bZXyYtAfpJ/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.v09wVbEbJV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 15:25: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:25: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 mozsystemmonitor==0.3 15:25:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bZXyYtAfpJ/Render', 15:25:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:25:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:25:46 INFO - 'HOME': '/Users/cltbld', 15:25:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:25:46 INFO - 'LOGNAME': 'cltbld', 15:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:46 INFO - 'MOZ_NO_REMOTE': '1', 15:25:46 INFO - 'NO_EM_RESTART': '1', 15:25:46 INFO - 'PAGER': '/bin/cat', 15:25:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:46 INFO - 'PWD': '/builds/slave/test', 15:25:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:25:46 INFO - 'SHELL': '/bin/bash', 15:25:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v09wVbEbJV/Listeners', 15:25:46 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 15:25:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:25:46 INFO - 'USER': 'cltbld', 15:25:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:25:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:46 INFO - 'XPC_FLAGS': '0x0', 15:25:46 INFO - 'XPC_SERVICE_NAME': '0', 15:25:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:25:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:25:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:25:49 INFO - Installing collected packages: mozsystemmonitor 15:25:49 INFO - Running setup.py install for mozsystemmonitor 15:25:49 INFO - Successfully installed mozsystemmonitor 15:25:49 INFO - Cleaning up... 15:25:49 INFO - Return code: 0 15:25:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109921490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109897570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb2248b2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109735d30>, '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 0x10955bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10972db20>, '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.bZXyYtAfpJ/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.v09wVbEbJV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 15:25:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:25:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:25:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bZXyYtAfpJ/Render', 15:25:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:25:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:25:49 INFO - 'HOME': '/Users/cltbld', 15:25:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:25:49 INFO - 'LOGNAME': 'cltbld', 15:25:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:49 INFO - 'MOZ_NO_REMOTE': '1', 15:25:49 INFO - 'NO_EM_RESTART': '1', 15:25:49 INFO - 'PAGER': '/bin/cat', 15:25:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:25:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:49 INFO - 'PWD': '/builds/slave/test', 15:25:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:25:49 INFO - 'SHELL': '/bin/bash', 15:25:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v09wVbEbJV/Listeners', 15:25:49 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 15:25:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:25:49 INFO - 'USER': 'cltbld', 15:25:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:25:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:25:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:49 INFO - 'XPC_FLAGS': '0x0', 15:25:49 INFO - 'XPC_SERVICE_NAME': '0', 15:25:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:50 INFO - Downloading/unpacking jsonschema==2.5.1 15:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:25:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:25: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 15:25: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 15:25: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 15:25: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 15:25: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 15:25: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 15:25:52 INFO - Downloading functools32-3.2.3-2.tar.gz 15:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:25:52 INFO - warning: no files found matching '*.txt' 15:25:52 INFO - no previously-included directories found matching 'build' 15:25:52 INFO - no previously-included directories found matching 'dist' 15:25:52 INFO - no previously-included directories found matching '.git*' 15:25:52 INFO - Installing collected packages: jsonschema, functools32 15:25:53 INFO - Running setup.py install for functools32 15:25:53 INFO - warning: no files found matching '*.txt' 15:25:53 INFO - no previously-included directories found matching 'build' 15:25:53 INFO - no previously-included directories found matching 'dist' 15:25:53 INFO - no previously-included directories found matching '.git*' 15:25:53 INFO - Successfully installed jsonschema functools32 15:25:53 INFO - Cleaning up... 15:25:53 INFO - Return code: 0 15:25:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:25:53 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')]} 15:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:53 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')]} 15:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:53 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 0x109921490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109897570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb2248b2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109735d30>, '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 0x10955bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10972db20>, '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.bZXyYtAfpJ/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.v09wVbEbJV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 15:25:53 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 15:25:53 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 15:25:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bZXyYtAfpJ/Render', 15:25:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:25:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:25:53 INFO - 'HOME': '/Users/cltbld', 15:25:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:25:53 INFO - 'LOGNAME': 'cltbld', 15:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:53 INFO - 'MOZ_NO_REMOTE': '1', 15:25:53 INFO - 'NO_EM_RESTART': '1', 15:25:53 INFO - 'PAGER': '/bin/cat', 15:25:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:53 INFO - 'PWD': '/builds/slave/test', 15:25:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:25:53 INFO - 'SHELL': '/bin/bash', 15:25:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v09wVbEbJV/Listeners', 15:25:53 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 15:25:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:25:53 INFO - 'USER': 'cltbld', 15:25:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:25:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:53 INFO - 'XPC_FLAGS': '0x0', 15:25:53 INFO - 'XPC_SERVICE_NAME': '0', 15:25:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:25:53 INFO - Cleaning up... 15:25:53 INFO - Return code: 0 15:25:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:25:53 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')]} 15:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:53 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')]} 15:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:53 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 0x109921490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109897570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb2248b2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109735d30>, '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 0x10955bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10972db20>, '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.bZXyYtAfpJ/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.v09wVbEbJV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 15:25:53 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 15:25:53 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 15:25:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bZXyYtAfpJ/Render', 15:25:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:25:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:25:53 INFO - 'HOME': '/Users/cltbld', 15:25:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:25:53 INFO - 'LOGNAME': 'cltbld', 15:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:53 INFO - 'MOZ_NO_REMOTE': '1', 15:25:53 INFO - 'NO_EM_RESTART': '1', 15:25:53 INFO - 'PAGER': '/bin/cat', 15:25:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:53 INFO - 'PWD': '/builds/slave/test', 15:25:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:25:53 INFO - 'SHELL': '/bin/bash', 15:25:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v09wVbEbJV/Listeners', 15:25:53 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 15:25:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:25:53 INFO - 'USER': 'cltbld', 15:25:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:25:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:53 INFO - 'XPC_FLAGS': '0x0', 15:25:53 INFO - 'XPC_SERVICE_NAME': '0', 15:25:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:53 INFO - Downloading/unpacking blobuploader==1.2.4 15:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:56 INFO - Downloading blobuploader-1.2.4.tar.gz 15:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:25:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:25:56 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 15:25:56 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 15:25:56 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 15:25:56 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 15:25:56 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 15:25:56 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 15:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:25:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:25:57 INFO - Downloading docopt-0.6.1.tar.gz 15:25:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:25:57 INFO - Installing collected packages: blobuploader, requests, docopt 15:25:57 INFO - Running setup.py install for blobuploader 15:25:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:25:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:25:57 INFO - Running setup.py install for requests 15:25:58 INFO - Running setup.py install for docopt 15:25:58 INFO - Successfully installed blobuploader requests docopt 15:25:58 INFO - Cleaning up... 15:25:58 INFO - Return code: 0 15:25:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:25: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')]} 15:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25: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')]} 15:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:58 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 0x109921490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109897570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb2248b2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109735d30>, '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 0x10955bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10972db20>, '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.bZXyYtAfpJ/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.v09wVbEbJV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 15:25:58 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 15:25:58 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 15:25:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bZXyYtAfpJ/Render', 15:25:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:25:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:25:58 INFO - 'HOME': '/Users/cltbld', 15:25:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:25:58 INFO - 'LOGNAME': 'cltbld', 15:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:58 INFO - 'MOZ_NO_REMOTE': '1', 15:25:58 INFO - 'NO_EM_RESTART': '1', 15:25:58 INFO - 'PAGER': '/bin/cat', 15:25:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:58 INFO - 'PWD': '/builds/slave/test', 15:25:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:25:58 INFO - 'SHELL': '/bin/bash', 15:25:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v09wVbEbJV/Listeners', 15:25:58 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 15:25:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:25:58 INFO - 'USER': 'cltbld', 15:25:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:25:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:58 INFO - 'XPC_FLAGS': '0x0', 15:25:58 INFO - 'XPC_SERVICE_NAME': '0', 15:25:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:25:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:25:58 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-iSuSk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:25:58 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-sn3d9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:25:59 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-C3idPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:25:59 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-8_mcCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:25:59 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-Bhcebp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:25:59 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-cKp4kf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:25:59 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-PmlsYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:25:59 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-vcSuMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:25:59 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-pBgjlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:25:59 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-Lxym67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:25:59 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-Zilhsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:26:00 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-pgi9Bn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:26:00 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-gR7STq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:26:00 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-CfmfrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:26:00 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-h8To6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:26:00 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-4XChiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:26:00 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-c9ZS91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:26:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:26:00 INFO - Running setup.py install for manifestparser 15:26:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:26:00 INFO - Running setup.py install for mozcrash 15:26:00 INFO - Running setup.py install for mozdebug 15:26:01 INFO - Running setup.py install for mozdevice 15:26:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:26:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:26:01 INFO - Running setup.py install for mozfile 15:26:01 INFO - Running setup.py install for mozhttpd 15:26:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:26:01 INFO - Running setup.py install for mozinfo 15:26:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:26:01 INFO - Running setup.py install for mozInstall 15:26:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:26:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:26:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:26:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:26:01 INFO - Running setup.py install for mozleak 15:26:01 INFO - Running setup.py install for mozlog 15:26:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:26:02 INFO - Running setup.py install for moznetwork 15:26:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:26:02 INFO - Running setup.py install for mozprocess 15:26:02 INFO - Running setup.py install for mozprofile 15:26:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:26:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:26:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:26:02 INFO - Running setup.py install for mozrunner 15:26:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:26:02 INFO - Running setup.py install for mozscreenshot 15:26:02 INFO - Running setup.py install for moztest 15:26:03 INFO - Running setup.py install for mozversion 15:26:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:26:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:26:03 INFO - Cleaning up... 15:26:03 INFO - Return code: 0 15:26:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:26:03 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')]} 15:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26: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')]} 15:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:04 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 0x109921490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109897570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb2248b2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109735d30>, '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 0x10955bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10972db20>, '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.bZXyYtAfpJ/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.v09wVbEbJV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 15:26:04 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 15:26:04 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 15:26:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bZXyYtAfpJ/Render', 15:26:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:26:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:26:04 INFO - 'HOME': '/Users/cltbld', 15:26:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:26:04 INFO - 'LOGNAME': 'cltbld', 15:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:04 INFO - 'MOZ_NO_REMOTE': '1', 15:26:04 INFO - 'NO_EM_RESTART': '1', 15:26:04 INFO - 'PAGER': '/bin/cat', 15:26:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:04 INFO - 'PWD': '/builds/slave/test', 15:26:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:26:04 INFO - 'SHELL': '/bin/bash', 15:26:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v09wVbEbJV/Listeners', 15:26:04 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 15:26:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:26:04 INFO - 'USER': 'cltbld', 15:26:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:26:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:04 INFO - 'XPC_FLAGS': '0x0', 15:26:04 INFO - 'XPC_SERVICE_NAME': '0', 15:26:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:26:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:26:04 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-oEOXXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:26:04 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)) 15:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:26:04 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-BMbIsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:26:05 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)) 15:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:26:05 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-HBg2Am-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:26:05 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)) 15:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:26:05 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-P4BPvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:26:05 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)) 15:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:26:05 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-ra1T9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:26:05 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)) 15:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:26:05 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-qMAS96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:26:05 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)) 15:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:26:05 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-CXx90t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:26:05 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)) 15:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:26:05 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-4UdjsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:26:05 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)) 15:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:26:05 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-sb8fua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:26:05 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)) 15:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:26:05 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-WikvM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:26:05 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)) 15:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:26:05 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-o2LLea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:26:06 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)) 15:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:26:06 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-zPXihy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:26:06 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)) 15:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:26:06 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-d1nhIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:26:06 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)) 15:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:26:06 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-8Flch7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:26:06 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)) 15:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:26:06 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-wsCiZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:26:06 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)) 15:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:26:06 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-hmIIAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:26:06 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)) 15:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:26:06 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-hqqjao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:26:06 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)) 15:26:06 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)) 15:26:06 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)) 15:26:06 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)) 15:26:06 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)) 15:26:06 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)) 15:26:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:26:06 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 15:26:06 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 15:26:06 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 15:26:06 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 15:26:06 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 15:26:06 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 15:26:09 INFO - Downloading blessings-1.6.tar.gz 15:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:26:09 INFO - Installing collected packages: blessings 15:26:09 INFO - Running setup.py install for blessings 15:26:09 INFO - Successfully installed blessings 15:26:09 INFO - Cleaning up... 15:26:09 INFO - Return code: 0 15:26:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:26:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:26:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:26:10 INFO - Reading from file tmpfile_stdout 15:26:10 INFO - Current package versions: 15:26:10 INFO - blessings == 1.6 15:26:10 INFO - blobuploader == 1.2.4 15:26:10 INFO - docopt == 0.6.1 15:26:10 INFO - functools32 == 3.2.3-2 15:26:10 INFO - jsonschema == 2.5.1 15:26:10 INFO - manifestparser == 1.1 15:26:10 INFO - mozInstall == 1.12 15:26:10 INFO - mozcrash == 1.0 15:26:10 INFO - mozdebug == 0.1 15:26:10 INFO - mozdevice == 0.48 15:26:10 INFO - mozfile == 1.2 15:26:10 INFO - mozhttpd == 0.7 15:26:10 INFO - mozinfo == 0.9 15:26:10 INFO - mozleak == 0.1 15:26:10 INFO - mozlog == 3.4 15:26:10 INFO - moznetwork == 0.27 15:26:10 INFO - mozprocess == 0.23 15:26:10 INFO - mozprofile == 0.28 15:26:10 INFO - mozrunner == 6.13 15:26:10 INFO - mozscreenshot == 0.1 15:26:10 INFO - mozsystemmonitor == 0.3 15:26:10 INFO - moztest == 0.7 15:26:10 INFO - mozversion == 1.4 15:26:10 INFO - psutil == 3.1.1 15:26:10 INFO - requests == 1.2.3 15:26:10 INFO - wsgiref == 0.1.2 15:26:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:26:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:10 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 0x109921490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109897570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb2248b2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109735d30>, '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 0x10955bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10972db20>, '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.bZXyYtAfpJ/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.v09wVbEbJV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 15:26:10 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 15:26:10 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 15:26:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bZXyYtAfpJ/Render', 15:26:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:26:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:26:10 INFO - 'HOME': '/Users/cltbld', 15:26:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:26:10 INFO - 'LOGNAME': 'cltbld', 15:26:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:10 INFO - 'MOZ_NO_REMOTE': '1', 15:26:10 INFO - 'NO_EM_RESTART': '1', 15:26:10 INFO - 'PAGER': '/bin/cat', 15:26:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:26:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:10 INFO - 'PWD': '/builds/slave/test', 15:26:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:26:10 INFO - 'SHELL': '/bin/bash', 15:26:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v09wVbEbJV/Listeners', 15:26:10 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 15:26:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:26:10 INFO - 'USER': 'cltbld', 15:26:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:26:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:26:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:10 INFO - 'XPC_FLAGS': '0x0', 15:26:10 INFO - 'XPC_SERVICE_NAME': '0', 15:26:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:26:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:10 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)) 15:26:10 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)) 15:26:10 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)) 15:26:10 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)) 15:26:10 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)) 15:26:10 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)) 15:26:10 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)) 15:26:10 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)) 15:26:10 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)) 15:26:10 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)) 15:26:10 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)) 15:26:10 INFO - Cleaning up... 15:26:10 INFO - Return code: 0 15:26:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:26:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:10 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 0x109921490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109897570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb2248b2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109735d30>, '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 0x10955bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10972db20>, '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.bZXyYtAfpJ/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.v09wVbEbJV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 15:26:10 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 15:26:10 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 15:26:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bZXyYtAfpJ/Render', 15:26:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:26:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:26:10 INFO - 'HOME': '/Users/cltbld', 15:26:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:26:10 INFO - 'LOGNAME': 'cltbld', 15:26:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:10 INFO - 'MOZ_NO_REMOTE': '1', 15:26:10 INFO - 'NO_EM_RESTART': '1', 15:26:10 INFO - 'PAGER': '/bin/cat', 15:26:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:26:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:10 INFO - 'PWD': '/builds/slave/test', 15:26:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:26:10 INFO - 'SHELL': '/bin/bash', 15:26:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v09wVbEbJV/Listeners', 15:26:10 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 15:26:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:26:10 INFO - 'USER': 'cltbld', 15:26:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:26:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:26:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:10 INFO - 'XPC_FLAGS': '0x0', 15:26:10 INFO - 'XPC_SERVICE_NAME': '0', 15:26:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:26:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:26:10 INFO - Cleaning up... 15:26:10 INFO - Return code: 0 15:26:10 INFO - Running post-action listener: _resource_record_post_action 15:26:10 INFO - Running post-action listener: _start_resource_monitoring 15:26:10 INFO - Starting resource monitoring. 15:26:10 INFO - [mozharness: 2016-11-15 23:26:10.680869Z] Finished create-virtualenv step (success) 15:26:10 INFO - [mozharness: 2016-11-15 23:26:10.681942Z] Running install step. 15:26:10 INFO - Running pre-action listener: _resource_record_pre_action 15:26:10 INFO - Running main action method: install 15:26:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:26:10 INFO - Reading from file tmpfile_stdout 15:26:10 INFO - Detecting whether we're running mozinstall >=1.0... 15:26:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:26:11 INFO - Reading from file tmpfile_stdout 15:26:11 INFO - Output received: 15:26:11 INFO - Usage: mozinstall [options] installer 15:26:11 INFO - Options: 15:26:11 INFO - -h, --help show this help message and exit 15:26:11 INFO - -d DEST, --destination=DEST 15:26:11 INFO - Directory to install application into. [default: 15:26:11 INFO - "/builds/slave/test"] 15:26:11 INFO - --app=APP Application being installed. [default: firefox] 15:26:11 INFO - mkdir: /builds/slave/test/build/application 15:26:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:26:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 15:26:44 INFO - Reading from file tmpfile_stdout 15:26:44 INFO - Output received: 15:26:44 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:26:44 INFO - Running post-action listener: _resource_record_post_action 15:26:44 INFO - [mozharness: 2016-11-15 23:26:44.742676Z] Finished install step (success) 15:26:44 INFO - [mozharness: 2016-11-15 23:26:44.742852Z] Running run-tests step. 15:26:44 INFO - Running pre-action listener: _resource_record_pre_action 15:26:44 INFO - Running main action method: run_tests 15:26:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:26:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:26:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:26:44 INFO - 2016-11-15 15:26:44.757 screenresolution[1909:15962] starting screenresolution argv=screenresolution get 15:26:44 INFO - 2016-11-15 15:26:44.760 screenresolution[1909:15962] Display 0: 1600x1200x32@60 15:26:44 INFO - 2016-11-15 15:26:44.766 screenresolution[1910:15965] starting screenresolution argv=screenresolution list 15:26:44 INFO - Available Modes on Display 0 15:26:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:26:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:26:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:26:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:26:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:26:44 INFO - Intel Iris: 15:26:44 INFO - Chipset Model: Intel Iris 15:26:44 INFO - Type: GPU 15:26:44 INFO - Bus: Built-In 15:26:44 INFO - VRAM (Dynamic, Max): 1536 MB 15:26:44 INFO - Vendor: Intel (0x8086) 15:26:44 INFO - Device ID: 0x0a2e 15:26:44 INFO - Revision ID: 0x0009 15:26:44 INFO - Displays: 15:26:44 INFO - Display: 15:26:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:26:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:26:44 INFO - Display Serial Number: 1600x1200 60 15:26:44 INFO - Main Display: Yes 15:26:44 INFO - Mirror: Off 15:26:44 INFO - Online: Yes 15:26:44 INFO - Rotation: Supported 15:26:44 INFO - Return code: 0 15:26:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:26:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:26:45 INFO - Python 2.7.3 15:26:45 INFO - Return code: 0 15:26:45 INFO - grabbing minidump binary from tooltool 15:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:26:45 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 0x109735d30>, '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 0x10955bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10972db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:26:45 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 15:26:45 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 15:26:45 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 15:26:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:26:45 INFO - Return code: 0 15:26:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:26:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:26:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:26:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:26:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:26:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dvdu9aQ6R0uWGZZ32z5uqg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0291', '--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 15:26:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dvdu9aQ6R0uWGZZ32z5uqg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0291 --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 15:26:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bZXyYtAfpJ/Render', 15:26:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:26:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:26:45 INFO - 'HOME': '/Users/cltbld', 15:26:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:26:45 INFO - 'LOGNAME': 'cltbld', 15:26:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:26:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:45 INFO - 'MOZ_NO_REMOTE': '1', 15:26:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:26:45 INFO - 'NO_EM_RESTART': '1', 15:26:45 INFO - 'PAGER': '/bin/cat', 15:26:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:45 INFO - 'PWD': '/builds/slave/test', 15:26:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:26:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:26:45 INFO - 'SHELL': '/bin/bash', 15:26:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v09wVbEbJV/Listeners', 15:26:45 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 15:26:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:26:45 INFO - 'USER': 'cltbld', 15:26:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:26:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:45 INFO - 'XPC_FLAGS': '0x0', 15:26:45 INFO - 'XPC_SERVICE_NAME': '0', 15:26:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:26:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dvdu9aQ6R0uWGZZ32z5uqg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0291', '--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 15:26:45 INFO - mozversion application_buildid: 20161115120248 15:26:45 INFO - mozversion application_changeset: 8616872c1e2299bd55ae435654de757f3175c494 15:26:45 INFO - mozversion application_display_name: Nightly 15:26:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:26:45 INFO - mozversion application_name: Firefox 15:26:45 INFO - mozversion application_remotingname: firefox 15:26:45 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 15:26:45 INFO - mozversion application_vendor: Mozilla 15:26:45 INFO - mozversion application_version: 52.0a1 15:26:45 INFO - mozversion platform_buildid: 20161115120248 15:26:45 INFO - mozversion platform_changeset: 8616872c1e2299bd55ae435654de757f3175c494 15:26:45 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 15:26:45 INFO - mozversion platform_version: 52.0a1 15:26:45 INFO - using testdate: 1479252405 15:26:45 INFO - actual date: 1479252405 15:26:45 INFO - starting webserver on 'localhost:52171' 15:26:45 INFO - SUITE-START | Running 2 tests 15:26:45 INFO - TEST-START | dromaeo_css 15:26:45 INFO - operating with platform_type : mac_ 15:26:45 INFO - Initialising browser for dromaeo_css test... 15:26:45 INFO - TEST-INFO | started process 1920 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmp4zLbAY/profile http://localhost:52171/getInfo.html) 15:26:47 INFO - PROCESS | 1920 | __metrics Screen width/height:1600/1200 15:26:47 INFO - PROCESS | 1920 | colorDepth:24 15:26:47 INFO - PROCESS | 1920 | Browser inner width/height: 1024/689 15:26:47 INFO - PROCESS | 1920 | __metrics 15:26:47 INFO - PROCESS | 1920 | 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" 15:26:47 INFO - PROCESS | 1920 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:26:48 INFO - TEST-INFO | 1920: exit 0 15:26:48 INFO - Browser initialized. 15:26:48 INFO - Running cycle 1/1 for dromaeo_css test... 15:26:48 INFO - TEST-INFO | started process 1922 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmp4zLbAY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:27:00 INFO - PROCESS | 1922 | RSS: Main: 240967680 15:27:00 INFO - PROCESS | 1922 | 15:27:51 INFO - PROCESS | 1922 | 1479252471867 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] 15:30:05 INFO - PROCESS | 1922 | Cycle 1(1): loaded http://localhost:52171/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52171/tests/dromaeo/cssquery-ext.html) 15:30:06 INFO - PROCESS | 1922 | RSS: Main: 402337792 15:30:06 INFO - PROCESS | 1922 | 15:33:09 INFO - PROCESS | 1922 | Cycle 1(1): loaded http://localhost:52171/tests/dromaeo/cssquery-ext.html (next: http://localhost:52171/tests/dromaeo/cssquery-jquery.html) 15:33:10 INFO - PROCESS | 1922 | RSS: Main: 372273152 15:33:10 INFO - PROCESS | 1922 | 15:36:12 INFO - PROCESS | 1922 | Cycle 1(1): loaded http://localhost:52171/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52171/tests/dromaeo/cssquery-mootools.html) 15:36:13 INFO - PROCESS | 1922 | RSS: Main: 358821888 15:36:13 INFO - PROCESS | 1922 | 15:39:15 INFO - PROCESS | 1922 | Cycle 1(1): loaded http://localhost:52171/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52171/tests/dromaeo/cssquery-prototype.html) 15:39:16 INFO - PROCESS | 1922 | RSS: Main: 354439168 15:39:16 INFO - PROCESS | 1922 | 15:42:19 INFO - PROCESS | 1922 | Cycle 1(1): loaded http://localhost:52171/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52171/tests/dromaeo/cssquery-yui.html) 15:42:20 INFO - PROCESS | 1922 | RSS: Main: 344297472 15:42:20 INFO - PROCESS | 1922 | 15:45:23 INFO - PROCESS | 1922 | Cycle 1(1): loaded http://localhost:52171/tests/dromaeo/cssquery-yui.html (next: http://localhost:52171/tests/dromaeo/cssquery-dojo.html) 15:45:24 INFO - PROCESS | 1922 | RSS: Main: 380223488 15:45:24 INFO - PROCESS | 1922 | 15:45:24 INFO - PROCESS | 1922 | __start_tp_report 15:45:24 INFO - PROCESS | 1922 | _x_x_mozilla_page_load 15:45:24 INFO - PROCESS | 1922 | _x_x_mozilla_page_load_details 15:45:24 INFO - PROCESS | 1922 | |i|pagename|runs| 15:45:24 INFO - PROCESS | 1922 | |0;dojo.html;2835.971640283597;3196.9360612787746;3221.4523530999722;3241.416545021898;3262.967370326296;5386.569074474042;5416.214648875915;5448.972755136228;5481.725913704318;5522.834314970552;4727.692699974499;5341.572674186065;5429.809956651508;5553.055980483307;5574.219609254707;4264.765437900915;4962.429320628138;5073.492650734934;5080.79676812927;5106.795728170869;5005.5244751748705;5041.1178043842365;5115.590752739772;5121.4110377306715;5131.179011358184;5117.744112794364;5125.564327032207;5131.230315452674;5144.536991670749;5196.506331898464;4984.501549845023;5006.349174607278;5023.899522009576;5050.065737838475;5077.136886729265;4098.303288440942;4996.300517927493;4998.775055122528;5011.6241281904;5032.094223039851;5316.840494785162;5410.296661434028;5445.156000819879;5471.562275017989;5509.531689806371;4949.604031677493;5837.824865254049;5997.910031349533;6051.394860513913;6053.939460605382;5461.918071228934;5899.5870289079785;5981.162637230791;6038.516918646497;6046.516278697693;5539.639923404966;5572.414896435897;5576.888462230732;5608.355039170548;5610.102383618601;6138.662373569497;6167.938320616737;6174.629522228591;6175.505959523227;6178.351273116258;5684.403137670568;5723.227364305849;5756.194132821408;5792.652440853562;5799.449052340021;5905.498032667186;5909.438603332676;5947.881042379215;5993.61041532299;5998.280206375263;5775.855603609859;5820.447057529613;5822.097574875901;5824.854378640568;5862.325832529228;4227.51383590891;5791.82624521265;5927.110933360031;5939.3763654816485;6005.939940600625;4741.502142275081;4753.857384278477;4762.166620841339;4764.904701905943;4776;4199.223143718422;4251.574842515785;4300.634446072057;4315.3095504719095;4316.935245971313;5533.529649979716;5536.390996990328;5537.889242215214;5541.722913854291;5543.972280138573;5126.384833819965;5797.985352563369;5979.103134529855;6034.818955431344;6036.788712395045;5470.835874923759;5485.930243602539;5512.91730624041;5522.420145884705;5528.806491772769;5133.9743301284;5176.870578235499;5185.9740701297005;5188;5190.403103643054;6243.188385509855;6254.405831446005;6268.592541484789;6284.4344009039405;6296.370362963667;5905.527557795452;6026.90959635597;6041.154238406714;6056.0915862619195;6064.757409703562;6148.200733904564;6151.015837465984;6199.876002479835;6207.6275423474735;6208.255009398901;5930.970345148246;5940.405959404025;5951.315598706205;5953.047512397996;5980.581359304807;5906.852328691817;6015.72929218195;6053.515718742578;6077.118817771487;6086.056661217518;5709.115087161496;5716.79991200306;5791.420857914175;5793;5811.738471768696;5760.135979603093;5890.558208134493;5904.996150654313;5917.970410148094;5941.435563621449;4866.05112003156;5696.458836410535;5711.771529138788;5720.856978575569;5748.051571490657;5737.48362647347;5825.6795876225515;5883.264591926009;5899.262592175978;5905.616134951214;5489.231507589021;5539.335279766454;5566.387697353207;5631.211630371833;5708.457696518824 15:45:24 INFO - PROCESS | 1922 | |1;ext.html;451.6138701410293;501.50601657367463;507.7537394363734;512.1114865707998;518.1450606499278;30347.544786828214;32287.67712322879;40304.59695403045;41463.58536414635;41483.79258103705;42185.36721949166;42622.78688606553;42674.7197584073;42770;42774.93062673427;9244.67643632473;9403.905960940405;9404.341696081277;9432.292578056638;9447.433154010747;9278.11857873501;9391.201747851406;9393.483358415284;9396.389234699756;9420.246380289595;9366.20387267083;9432.858507122399;9435.952820235889;9445.952770236174;9446.716598502057;9329.95335023324;9384.953075234649;9395.718128456158;9395.859062114108;9403.341766076377;8074.273315401583;9267.814643707088;9335.626574936994;9348.158665720119;9352.018038105969;40276.194476110315;40546.18907621831;40571.188576228604;40571.98570035743;40584.188316233805;3189.681031896815;3216.485362342014;3232.531282963957;3408.625051244361;3424.092615456906;29751.404971900658;30117.548236776467;30586.38827223443;31214.843925780453;31308.373832523448;3173.9682603173906;3212.5984251968503;3222.677732226782;3240.189952511872;3348.029071569242;503096;509001;509829;510367.4481627605;510936;55706.72146639322;56147.71926140343;56166;56247;56276.71861640666;34629.480557791656;35388.292234155684;35453.290934181176;60955;61254.77490450166;15765.211739412984;16001.519954401387;16153.838461615233;16179.919100404659;16209.837901620833;12288.938555307166;12400.255984640951;12409;12416.689582760322;12438.440270187863;14769.778453323208;18775.87344759319;18860.45383873187;18901.015393383772;18904;6488.967555162194;6491.156149700603;7523.924760752322;7758.534487930629;7802.180771018961;784.2199403115853;841.6696098572809;877.2587163846539;956.9234461243084;1054.8101341758404;22400.775992240197;23415.882920585627;28791.56812647812;29440.263993400335;29645.258868528028;846.8433339832151;993.8608594796734;1049.4070849969742;1083.3878858445112;1111.5776005118003;14967.700645987237;14982.925085374503;15262.141129612868;15295.235238238043;15383;672165;678462;678901;681913;682587;57041;57476;57542.42457575371;57566;57696.13455798166;1210.5218438716659;1244.3715923458597;1248.2011512631923;1348.7032852772375;1367.0772228745557;25710.485790283714;28585.42829143447;31496.842515787273;31499.370012600077;32354.83822580872;45080.77459612681;53738.46261537491;54514.18228726493;54597;54709.63225919384;589325;614951;620753;622845;622977;23510.764892350857;24089.397765055313;26186;26321.736782631928;26556.46887062209;45473.772631136635;45488.84092124274;45556.86107847198;46681.83295417642;46983.590492285286;37299.06752331105;37415.2516949654;37663.05842353963;38556;38674.61325386823;31443.528347074356;37550.43674344832;37556.2488750218;38705;38861.80569097136;36176.45735314025;36634;37232;37549.06127346838;37695.81152094222;25885.741142588333;31705.841470792497;31963.680363196072;32247;33733.3253334927;24538.63192052085;24742.50514989654;24794.380140496633;24854.751452485965;25088.48053428243 15:45:24 INFO - PROCESS | 1922 | |2;jquery.html;346.8907294202328;362.8657396763198;366.71029886389755;376.3827323189967;398.2751392465712;14518.056326338794;14993.550193494199;15715.371385144581;20205.797942020574;20627.1749130035;18754.624907501842;19339.903300483515;19479.61040779187;19649.803501964976;19701.21195152192;5100.642954993143;5353.357597088336;5354.170103633943;5365.865853353678;5366.490183432587;4527.705699129562;5293.15309550472;5894.616849904743;5954.821355359324;5964.910526342108;5906.970465147669;5909.556783241253;5910.379410161936;5923.88152236955;5927.496162826165;5274.446183150791;5278.181881808307;5307.867303317409;5318.175682769177;5329.387120481156;4940.184869496528;5159.458256883011;5167.044096842096;5168.741562921877;5171.663841850268;12926.96584273256;14194.645133871736;18566.90716546422;24876;24889.128880489097;2146.152269853399;2158.589867925089;2172.4134483689472;2227.1982086448866;2384.0582969727034;9630.855537166948;9658.034196580356;10155.187584993257;10182.338148020355;14414.207218602973;1791.8566514678794;1857.3220774417375;1858.349577647826;1884.962300753991;1907.7901430842596;107620.92379076187;115534.84465155409;120754.7547147174;122516;122916.38541807323;8988.775280618036;9126.954365228265;9547.809043819223;9779.706608801747;10146.13757830578;11265.817089205515;11325.150613704005;11847.585334513251;12240.44917978693;12352.44414001372;6503.772367967098;6598.3401659833635;7656.540607563564;7977.2022797719765;8082.31300339466;7259.983602295682;7493.925060749431;7952.165022672536;8051.114377418479;8224.712135075244;3712.535933008374;3766.4350347448103;3798.9810050950123;3855;3865.4974853268895;1886.6698327792856;1915.7413749143686;1920.6280243898773;1945.8346040586425;1961.2743284984647;828.9378296627657;911.5824892292417;924.5146298193503;970.9126178643814;982.29274922056;20082.69875951862;20638.896805515877;21351.359459216248;21518.677219841717;21519.78480215209;894.2577660541734;906.6146887572755;909.0954500272271;917.660465627722;963.426761077158;10649.893501065046;10710.250282480307;11069.335839849635;11311.604093856675;11380.658580242605;580190;584239;594536.4644005222;595870;599423.0375025609;104879.47560262303;124371;129001.35499322444;129665.05502417471;132353;930.6044930904338;938.4697645830084;995.6664517386756;1008.1732978957331;1013.761765984993;18569.81430185735;19491.220351185795;19614.90192549028;19616.411507654793;19636.50908727236;36050.45924311085;50690.493095068574;51895.78183557936;51916;52609.736951315;74567;75989.62005189939;78562;78575;79473;5389.730513474232;5747.023006089058;6297.496200304056;7146.678399471933;7260.4554658399775;12053.888205958176;12426.316552589695;12854.935725321313;12988.610341689764;13298.202107873172;10928.50821713009;11327.376994265065;11372.54509819598;11488.080953523531;11494.54021839117;10917.836232456679;11071.612493563009;11179.66461006171;11286.548538058385;11370.43147842588;10802.297850639683;11376.544938202711;11623.418829058683;11656.592019279284;11752.70618234551;8077.959610201911;8183.79540511492;8184.7953801155445;8230.382721295808;8236.83526329482;9388.483633400228;9795.9020409795;10899.618513351994;10949.83575246356;10982.450877455936 15:45:24 INFO - PROCESS | 1922 | |3;mootools.html;1225.994684358825;1495.45415923188;1508.4720347878242;1690.8224636413177;1871.5601833569117;7301.890471642923;7891.408144389172;7976.162502937188;8370.121137280574;8387.496750194992;8225.712100076484;8250.504969701822;8309.127541608119;8389.37079719022;8394.748157555283;2288.324944141474;2333.9066437342485;2338.1816364272454;2338.3569518382496;2338.684277622516;2316.9652455213186;2355.729091154522;2372.5966585680476;2375.1449478187837;2375.572396968545;2315.0855412112205;2318.5594737;2342.8711420871846;2343.1330407749156;2347.4600841806396;2295.185209250709;2302.297799171252;2327.4871333633105;2330.498942727305;2344;2320.0951628864755;2343.94140146496;2349.8825058746993;2352.5059737455153;2353.682252895854;8269.751907442786;8419.915800841974;8430.32557395407;8430.578471076484;8440.366972477088;4345.84789532368;5038.067957427887;5207.9479205207845;5213.2701421800975;5226.5818734501145;3465.4455287154187;3540.5928318243473;3559.48387483816;3559.768615040014;3560.0743806610467;882.3735148044896;1076.8653918260218;1082.5561519776932;1721.1050253868043;1752.9298828046863;10886.945565272203;10940.945295273552;11025.503852326585;11025.897410258991;11038.061764750006;3724.981375093107;4209.305464598368;4414.006848459071;4459.643228541709;4465.977670111693;8716.171963663443;8724.95637521821;8731.083236260229;8753;8758.255548278341;5012.147934851084;5127.87180320495;5133.024725302181;5133.076046311625;5135.204043373283;4057.4522439470884;4261.97869010653;4420.093880754438;4441.022974945507;4757.619390448755;3560.092176495029;3592.946105808415;3663.853445862189;3669.486271921933;3680.5583330000572;1137.9317240965404;1143.1312202725987;1147.6040765935907;1156.3408856951457;1161.7386088130104;787.7833595761211;854.8888644476178;877.9604917778715;928.9535523223811;935.6257497001254;5557.749901254453;5663.716814159276;5748.39641837601;5767.798127065533;6051.243594550681;828.3000864269683;847.1993965702352;871.107115206918;912.7723212279474;913.3332667152882;3308.6035658729324;3581.516495273157;3693.409054551259;3852.499175107218;3952.3676211805973;9789.412635241908;10291.125254353314;10317.742056448498;10317.84523232152;10326.48367581633;10265.435401053013;10275.7431064224;10279.074883260393;10280.537375818107;10296.742581435374;7733.7679869604;7848.175941526171;7851.725189618336;8025.598720063974;8030.196980301923;5585.636933599303;5661.122526008476;5698.914516282342;5770.769169233184;5805.680687562056;9319.021502742115;9492.099885361167;9529.332946693665;9555.761105972406;9594.376365536218;9548.474833883925;9599.088086631758;9683.757906052406;9718.173955213602;9806.852897206405;6711.0940023096255;6817.965910170417;6845.520813543004;6891.104156459628;6897.7240910363025;7874.13384527713;7915.525068495908;7996.800079998046;8014.639341229776;8026.919730802851;7139.8572028560175;7246.96376518114;7253.202147763636;7305.342519173088;7379.114506259283;7091.574505529685;7111.431085513043;7116.46626503004;7155.069840920647;7222.855542889008;6685.164354455693;6692.899606505809;6771.289014653587;6781.457483401217;6786.76246331376;4659.906801864012;4831.492693267156;4877.487863774394;4939.901201975868;5047.444781074152;4827.155247831685;4862.659613826998;4943.134951383566;4976.776045077908;4992.950070499249 15:45:24 INFO - PROCESS | 1922 | |4;prototype.html;299.2175461169043;300.7894473868291;306.76685718853673;315.0092957648196;316.89067271791254;4868.342773725546;4923.359963204783;4973.900521989558;5124;5195.662281951671;4037.75773453593;4160.37594360846;4244.702870799046;4492.663050271226;4608;3580.997320750194;3622;3848.6728628066576;3881.3207688654516;3930.744501607386;3405.0125463615523;3923.7449565778275;3925.9214815703667;3927.2341893330813;3967.26605577969;3233.8059716416974;3393.6267010628812;3580.3913334733156;3714.16431302956;3829.3681542545587;3206.9198270043203;3872.3997780344093;3873.205992771475;3896.201278737852;3903.8438462461468;3381.5773028371455;3390.542276792626;3398.3543126805826;3420.7776494527775;3422.5379573757473;4369.563043695637;4996.851353917814;5002.19964805633;5005.74971251436;5018.447970723218;3624.8187590620364;4256.935386337624;4417.845375411845;4445.933311000337;4458.643308535342;4556.29377446493;5143.27994080829;5328.600354973392;5330.413654498002;5338.973305133488;3164.7309978651842;3644;3699.981500092509;3702.907427314312;3722.571904231021;4794.256890182028;4935.877572643762;5085.67772379184;5217.47825217479;5637.280629408029;3095.9845200773852;3684.871029513954;3694.8152592370275;3697.5949139326885;3721.14413684854;3767.472553842464;3778.282126395976;3779.108981629056;3784.4701741756176;3788.507494025814;3861.420786881934;4180.979095104566;4193.329067349209;4205.453291072202;4343.956560434419;5065.480355893217;5175.327207463006;5363.624546281723;5411.133159060118;5429.538489228381;1064.9094826939643;1188.2810899405736;1228.5331574001823;1236.9814452783216;1240.6340129661771;732.8973943647893;794.4121350200925;806.9354451643854;839.412411312084;849.9235068843834;4076.9388459173138;4212.957870421256;4890.747652810841;4893.828715994923;5144.485551444825;5180.766865491062;5568.6658800472105;5573.3805111597485;5574.414686457863;5600.915986260209;4782.163121453732;5130.51260130287;5134.948650513447;5183;5200.681172375582;2370.893309801063;2730.781537476997;2742.5337692592307;2825.7456828885497;2845.979354658216;4814.711117332971;4836.347093142381;4877.926831097537;5280.445553216934;5547.837732492521;4524.470912688109;5099.566536844335;5198.466452396552;5783.3323343123975;5898.970505147447;4816.638752093677;5898.970505147447;5953;5970.641761494324;5996.940030599638;4971.850844474671;4984.476629953802;4994.775235114501;5646.491815736604;5648.63283886546;4537.343869487548;5142.228665700175;5561.777528898799;5573.972130139486;5589.441055894378;5847.298324201123;5851.414858514115;5855.268091488564;5860.150278209721;5875.970620146872;3513.314903593877;3755.9248815024093;3803.6386543278345;3820.3123437781464;3825.69394448449;4775.689580177277;5480.671159730429;5510.677437415072;5555.805546805843;5594.496495315441;5412.539934105645;5444.071722375229;5454.918176227439;5467.234587157722;5475.288212532345;5221.329174664071;5426.810061647823;5441.238226648352;5454.563634909118;5547.306586676666;4672.014393882654;4936.679115857458;5340.839774806762;5352.357717073976;5360.391882435331;4484.443866995781;5156.9428267205885;5197.480251974772;5360.973195133999;5391.272178255886;4899.044686286283;5247.291615631993;5357.848062666545;5386.380566234777;5397.3523177218985 15:45:24 INFO - PROCESS | 1922 | |5;yui.html;690.903273541704;727.8034930568743;753.984920301594;786.4219798448136;792.7740593930731;14497.130172189663;15065.020773649705;15103.77344339833;15109.924450377734;15109.924450377746;13537.864621353783;13684.589462316122;13689.726205475885;13693.726125477484;13706.931465342685;645.5513418174371;670.5674839728372;676.4960104721964;783.5181363461459;807.0799288810746;817.1746535998625;823.6952327638782;824.2705205892798;825.5211977053325;826.0912995704707;860.4837097741367;876.8290183414236;878.0210065776645;878.4553576782372;880.4145243413122;865.3812524045275;866.5104216117904;867.9132086791302;869.2003356911594;869.5347988825948;506.06630766236236;519.7401299350324;521.4160140642467;647.2039391548375;649.4641920415676;11983.28100313984;11983.88016119845;11999.040076793923;13173.538926137539;13648;13158;13353.399097040656;13571.321433928264;13603.31983400826;13626.931865340708;11148.832767508495;11244.550217991271;11245.662630121027;11507.482163302671;11723.765524689543;3642.1987162824134;3648.7810731356203;3680.907977300562;3708.4993525873933;3830.5211848518934;61129.6943515284;85901.28197436016;86542.70185947216;86658.56670716606;88317.55841220752;8807.867881981776;10602.89397106019;10608.098311643442;10612.905467795768;11013.889861101447;20452.69320960157;20747.273845415337;20758.169673212902;21053.473663158544;21085.367438976857;7484.700611975569;7550.093988721279;7625;7630.923690763132;7654.502457340366;4146.398772178078;4170.812313445902;4202.075543380452;4207.621314081686;4235.8729238122905;3536.823158842099;3784.791836449022;3787.962120378816;3790.0524868782804;3820.331441997639;598.60791181776;680.323078536859;681.1315572644918;696.8919817428206;703.3248081841388;574.0270241939955;603.7652999615797;606.3118360660682;650.3139188156446;663.9634820084942;9286.071392860795;9494.287928405398;9588;9591.568379422943;9870.802583948282;638.9201349831271;640.2061443809642;650.9902351464732;653.3074940563018;674.7874419557824;3804.5853697302286;4214.4099826024385;4280.892977675583;4286.057067445219;4420.381146639473;100962;102513.97486025194;103598;105397;106171;56587.86824263492;58365.41634583685;59676;59873;74212;77553;78857;81614.77577836218;81924.59037704773;82100;8712.825743485222;9121.543922803967;9124.31567632417;9231.261499080192;9355.158035776813;50300.742481438254;50740.746296268284;52336.476635234685;54412.45587544074;55505;63603.6819815898;63799.36200637934;65261;71377;74672;11632.18574699763;11945.4027298633;11951.94024029909;12164.635060948185;12433.502659893504;11228.326300422;13259.270740109387;13272.601821945356;13376.933115334361;13378.531751388655;12247.247893111997;12319.50721971147;12345.753084938431;12478.87521124777;12654.87345126537;12260.38698065111;12288.201266917622;12542.122051456676;12662;12838.486460541473;11973.940130299292;12184.939075304921;12461.750764984468;12651;12749.93625031869;9976.403775395902;10913.83629245546;10935.125189984941;11118.332900026024;11279.943600281946;9065;10633.521491533054;10951.123910087015;10988.615398461016;11044.33733975964 15:45:24 INFO - PROCESS | 1922 | __end_tp_report 15:45:24 INFO - PROCESS | 1922 | __start_cc_report 15:45:24 INFO - PROCESS | 1922 | _x_x_mozilla_cycle_collect,1636 15:45:24 INFO - PROCESS | 1922 | __end_cc_report 15:45:24 INFO - PROCESS | 1922 | __startTimestamp1479253524030__endTimestamp 15:45:24 INFO - PROCESS | 1922 | 15:45:24 INFO - PROCESS | 1922 | ------- Summary: start ------- 15:45:24 INFO - PROCESS | 1922 | Number of tests: 6 15:45:24 INFO - PROCESS | 1922 | 15:45:24 INFO - PROCESS | 1922 | [#0] dojo.html Cycles:165 Average:5484.40 Median:5610.10 stddev:645.29 (11.5%) stddev-sans-first:612.91 15:45:24 INFO - PROCESS | 1922 | Values: 2836.0 3196.9 3221.5 3241.4 3263.0 5386.6 5416.2 5449.0 5481.7 5522.8 4727.7 5341.6 5429.8 5553.1 5574.2 4264.8 4962.4 5073.5 5080.8 5106.8 5005.5 5041.1 5115.6 5121.4 5131.2 5117.7 5125.6 5131.2 5144.5 5196.5 4984.5 5006.3 5023.9 5050.1 5077.1 4098.3 4996.3 4998.8 5011.6 5032.1 5316.8 5410.3 5445.2 5471.6 5509.5 4949.6 5837.8 5997.9 6051.4 6053.9 5461.9 5899.6 5981.2 6038.5 6046.5 5539.6 5572.4 5576.9 5608.4 5610.1 6138.7 6167.9 6174.6 6175.5 6178.4 5684.4 5723.2 5756.2 5792.7 5799.4 5905.5 5909.4 5947.9 5993.6 5998.3 5775.9 5820.4 5822.1 5824.9 5862.3 4227.5 5791.8 5927.1 5939.4 6005.9 4741.5 4753.9 4762.2 4764.9 4776.0 4199.2 4251.6 4300.6 4315.3 4316.9 5533.5 5536.4 5537.9 5541.7 5544.0 5126.4 5798.0 5979.1 6034.8 6036.8 5470.8 5485.9 5512.9 5522.4 5528.8 5134.0 5176.9 5186.0 5188.0 5190.4 6243.2 6254.4 6268.6 6284.4 6296.4 5905.5 6026.9 6041.2 6056.1 6064.8 6148.2 6151.0 6199.9 6207.6 6208.3 5931.0 5940.4 5951.3 5953.0 5980.6 5906.9 6015.7 6053.5 6077.1 6086.1 5709.1 5716.8 5791.4 5793.0 5811.7 5760.1 5890.6 5905.0 5918.0 5941.4 4866.1 5696.5 5711.8 5720.9 5748.1 5737.5 5825.7 5883.3 5899.3 5905.6 5489.2 5539.3 5566.4 5631.2 5708.5 15:45:24 INFO - PROCESS | 1922 | 15:45:24 INFO - PROCESS | 1922 | [#1] ext.html Cycles:180 Average:71824.07 Median:40425.39 stddev:162046.13 (400.9%) stddev-sans-first:162412.10 15:45:24 INFO - PROCESS | 1922 | Values: 451.6 501.5 507.8 512.1 518.1 30347.5 32287.7 40304.6 41463.6 41483.8 42185.4 42622.8 42674.7 42770.0 42774.9 9244.7 9403.9 9404.3 9432.3 9447.4 9278.1 9391.2 9393.5 9396.4 9420.2 9366.2 9432.9 9436.0 9446.0 9446.7 9330.0 9385.0 9395.7 9395.9 9403.3 8074.3 9267.8 9335.6 9348.2 9352.0 40276.2 40546.2 40571.2 40572.0 40584.2 3189.7 3216.5 3232.5 3408.6 3424.1 29751.4 30117.5 30586.4 31214.8 31308.4 3174.0 3212.6 3222.7 3240.2 3348.0 503096.0 509001.0 509829.0 510367.4 510936.0 55706.7 56147.7 56166.0 56247.0 56276.7 34629.5 35388.3 35453.3 60955.0 61254.8 15765.2 16001.5 16153.8 16179.9 16209.8 12288.9 12400.3 12409.0 12416.7 12438.4 14769.8 18775.9 18860.5 18901.0 18904.0 6489.0 6491.2 7523.9 7758.5 7802.2 784.2 841.7 877.3 956.9 1054.8 22400.8 23415.9 28791.6 29440.3 29645.3 846.8 993.9 1049.4 1083.4 1111.6 14967.7 14982.9 15262.1 15295.2 15383.0 672165.0 678462.0 678901.0 681913.0 682587.0 57041.0 57476.0 57542.4 57566.0 57696.1 1210.5 1244.4 1248.2 1348.7 1367.1 25710.5 28585.4 31496.8 31499.4 32354.8 45080.8 53738.5 54514.2 54597.0 54709.6 589325.0 614951.0 620753.0 622845.0 622977.0 23510.8 24089.4 26186.0 26321.7 26556.5 45473.8 45488.8 45556.9 46681.8 46983.6 37299.1 37415.3 37663.1 38556.0 38674.6 31443.5 37550.4 37556.2 38705.0 38861.8 36176.5 36634.0 37232.0 37549.1 37695.8 25885.7 31705.8 31963.7 32247.0 33733.3 24538.6 24742.5 24794.4 24854.8 25088.5 15:45:24 INFO - PROCESS | 1922 | 15:45:24 INFO - PROCESS | 1922 | [#2] jquery.html Cycles:180 Average:34028.55 Median:18206.66 stddev:98693.73 (542.1%) stddev-sans-first:98938.19 15:45:24 INFO - PROCESS | 1922 | Values: 346.9 362.9 366.7 376.4 398.3 14518.1 14993.6 15715.4 20205.8 20627.2 18754.6 19339.9 19479.6 19649.8 19701.2 5100.6 5353.4 5354.2 5365.9 5366.5 4527.7 5293.2 5894.6 5954.8 5964.9 5907.0 5909.6 5910.4 5923.9 5927.5 5274.4 5278.2 5307.9 5318.2 5329.4 4940.2 5159.5 5167.0 5168.7 5171.7 12927.0 14194.6 18566.9 24876.0 24889.1 2146.2 2158.6 2172.4 2227.2 2384.1 9630.9 9658.0 10155.2 10182.3 14414.2 1791.9 1857.3 1858.3 1885.0 1907.8 107620.9 115534.8 120754.8 122516.0 122916.4 8988.8 9127.0 9547.8 9779.7 10146.1 11265.8 11325.2 11847.6 12240.4 12352.4 6503.8 6598.3 7656.5 7977.2 8082.3 7260.0 7493.9 7952.2 8051.1 8224.7 3712.5 3766.4 3799.0 3855.0 3865.5 1886.7 1915.7 1920.6 1945.8 1961.3 828.9 911.6 924.5 970.9 982.3 20082.7 20638.9 21351.4 21518.7 21519.8 894.3 906.6 909.1 917.7 963.4 10649.9 10710.3 11069.3 11311.6 11380.7 580190.0 584239.0 594536.5 595870.0 599423.0 104879.5 124371.0 129001.4 129665.1 132353.0 930.6 938.5 995.7 1008.2 1013.8 18569.8 19491.2 19614.9 19616.4 19636.5 36050.5 50690.5 51895.8 51916.0 52609.7 74567.0 75989.6 78562.0 78575.0 79473.0 5389.7 5747.0 6297.5 7146.7 7260.5 12053.9 12426.3 12854.9 12988.6 13298.2 10928.5 11327.4 11372.5 11488.1 11494.5 10917.8 11071.6 11179.7 11286.5 11370.4 10802.3 11376.5 11623.4 11656.6 11752.7 8078.0 8183.8 8184.8 8230.4 8236.8 9388.5 9795.9 10899.6 10949.8 10982.5 15:45:24 INFO - PROCESS | 1922 | 15:45:24 INFO - PROCESS | 1922 | [#3] mootools.html Cycles:180 Average:5450.69 Median:5087.66 stddev:3002.15 (59.0%) stddev-sans-first:2993.78 15:45:24 INFO - PROCESS | 1922 | Values: 1226.0 1495.5 1508.5 1690.8 1871.6 7301.9 7891.4 7976.2 8370.1 8387.5 8225.7 8250.5 8309.1 8389.4 8394.7 2288.3 2333.9 2338.2 2338.4 2338.7 2317.0 2355.7 2372.6 2375.1 2375.6 2315.1 2318.6 2342.9 2343.1 2347.5 2295.2 2302.3 2327.5 2330.5 2344.0 2320.1 2343.9 2349.9 2352.5 2353.7 8269.8 8419.9 8430.3 8430.6 8440.4 4345.8 5038.1 5207.9 5213.3 5226.6 3465.4 3540.6 3559.5 3559.8 3560.1 882.4 1076.9 1082.6 1721.1 1752.9 10886.9 10940.9 11025.5 11025.9 11038.1 3725.0 4209.3 4414.0 4459.6 4466.0 8716.2 8725.0 8731.1 8753.0 8758.3 5012.1 5127.9 5133.0 5133.1 5135.2 4057.5 4262.0 4420.1 4441.0 4757.6 3560.1 3592.9 3663.9 3669.5 3680.6 1137.9 1143.1 1147.6 1156.3 1161.7 787.8 854.9 878.0 929.0 935.6 5557.7 5663.7 5748.4 5767.8 6051.2 828.3 847.2 871.1 912.8 913.3 3308.6 3581.5 3693.4 3852.5 3952.4 9789.4 10291.1 10317.7 10317.8 10326.5 10265.4 10275.7 10279.1 10280.5 10296.7 7733.8 7848.2 7851.7 8025.6 8030.2 5585.6 5661.1 5698.9 5770.8 5805.7 9319.0 9492.1 9529.3 9555.8 9594.4 9548.5 9599.1 9683.8 9718.2 9806.9 6711.1 6818.0 6845.5 6891.1 6897.7 7874.1 7915.5 7996.8 8014.6 8026.9 7139.9 7247.0 7253.2 7305.3 7379.1 7091.6 7111.4 7116.5 7155.1 7222.9 6685.2 6692.9 6771.3 6781.5 6786.8 4659.9 4831.5 4877.5 4939.9 5047.4 4827.2 4862.7 4943.1 4976.8 4993.0 15:45:24 INFO - PROCESS | 1922 | 15:45:24 INFO - PROCESS | 1922 | [#4] prototype.html Cycles:180 Average:4323.50 Median:4884.34 stddev:1354.24 (27.7%) stddev-sans-first:1323.93 15:45:24 INFO - PROCESS | 1922 | Values: 299.2 300.8 306.8 315.0 316.9 4868.3 4923.4 4973.9 5124.0 5195.7 4037.8 4160.4 4244.7 4492.7 4608.0 3581.0 3622.0 3848.7 3881.3 3930.7 3405.0 3923.7 3925.9 3927.2 3967.3 3233.8 3393.6 3580.4 3714.2 3829.4 3206.9 3872.4 3873.2 3896.2 3903.8 3381.6 3390.5 3398.4 3420.8 3422.5 4369.6 4996.9 5002.2 5005.7 5018.4 3624.8 4256.9 4417.8 4445.9 4458.6 4556.3 5143.3 5328.6 5330.4 5339.0 3164.7 3644.0 3700.0 3702.9 3722.6 4794.3 4935.9 5085.7 5217.5 5637.3 3096.0 3684.9 3694.8 3697.6 3721.1 3767.5 3778.3 3779.1 3784.5 3788.5 3861.4 4181.0 4193.3 4205.5 4344.0 5065.5 5175.3 5363.6 5411.1 5429.5 1064.9 1188.3 1228.5 1237.0 1240.6 732.9 794.4 806.9 839.4 849.9 4076.9 4213.0 4890.7 4893.8 5144.5 5180.8 5568.7 5573.4 5574.4 5600.9 4782.2 5130.5 5134.9 5183.0 5200.7 2370.9 2730.8 2742.5 2825.7 2846.0 4814.7 4836.3 4877.9 5280.4 5547.8 4524.5 5099.6 5198.5 5783.3 5899.0 4816.6 5899.0 5953.0 5970.6 5996.9 4971.9 4984.5 4994.8 5646.5 5648.6 4537.3 5142.2 5561.8 5574.0 5589.4 5847.3 5851.4 5855.3 5860.2 5876.0 3513.3 3755.9 3803.6 3820.3 3825.7 4775.7 5480.7 5510.7 5555.8 5594.5 5412.5 5444.1 5454.9 5467.2 5475.3 5221.3 5426.8 5441.2 5454.6 5547.3 4672.0 4936.7 5340.8 5352.4 5360.4 4484.4 5156.9 5197.5 5361.0 5391.3 4899.0 5247.3 5357.8 5386.4 5397.4 15:45:24 INFO - PROCESS | 1922 | 15:45:24 INFO - PROCESS | 1922 | [#5] yui.html Cycles:180 Average:18818.51 Median:4353.22 stddev:26548.06 (609.8%) stddev-sans-first:26587.64 15:45:24 INFO - PROCESS | 1922 | Values: 690.9 727.8 754.0 786.4 792.8 14497.1 15065.0 15103.8 15109.9 15109.9 13537.9 13684.6 13689.7 13693.7 13706.9 645.6 670.6 676.5 783.5 807.1 817.2 823.7 824.3 825.5 826.1 860.5 876.8 878.0 878.5 880.4 865.4 866.5 867.9 869.2 869.5 506.1 519.7 521.4 647.2 649.5 11983.3 11983.9 11999.0 13173.5 13648.0 13158.0 13353.4 13571.3 13603.3 13626.9 11148.8 11244.6 11245.7 11507.5 11723.8 3642.2 3648.8 3680.9 3708.5 3830.5 61129.7 85901.3 86542.7 86658.6 88317.6 8807.9 10602.9 10608.1 10612.9 11013.9 20452.7 20747.3 20758.2 21053.5 21085.4 7484.7 7550.1 7625.0 7630.9 7654.5 4146.4 4170.8 4202.1 4207.6 4235.9 3536.8 3784.8 3788.0 3790.1 3820.3 598.6 680.3 681.1 696.9 703.3 574.0 603.8 606.3 650.3 664.0 9286.1 9494.3 9588.0 9591.6 9870.8 638.9 640.2 651.0 653.3 674.8 3804.6 4214.4 4280.9 4286.1 4420.4 100962.0 102514.0 103598.0 105397.0 106171.0 56587.9 58365.4 59676.0 59873.0 74212.0 77553.0 78857.0 81614.8 81924.6 82100.0 8712.8 9121.5 9124.3 9231.3 9355.2 50300.7 50740.7 52336.5 54412.5 55505.0 63603.7 63799.4 65261.0 71377.0 74672.0 11632.2 11945.4 11951.9 12164.6 12433.5 11228.3 13259.3 13272.6 13376.9 13378.5 12247.2 12319.5 12345.8 12478.9 12654.9 12260.4 12288.2 12542.1 12662.0 12838.5 11973.9 12184.9 12461.8 12651.0 12749.9 9976.4 10913.8 10935.1 11118.3 11279.9 9065.0 10633.5 10951.1 10988.6 11044.3 15:45:24 INFO - PROCESS | 1922 | -------- Summary: end -------- 15:45:24 INFO - PROCESS | 1922 | 15:45:24 INFO - TEST-INFO | 1922: exit 0 15:45:24 INFO - TEST-OK | dromaeo_css | took 1119447ms 15:45:24 INFO - TEST-START | kraken 15:45:24 INFO - operating with platform_type : mac_ 15:45:24 INFO - Initialising browser for kraken test... 15:45:24 INFO - TEST-INFO | started process 1928 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmp66OJXT/profile http://localhost:52171/getInfo.html) 15:45:27 INFO - PROCESS | 1928 | __metrics Screen width/height:1600/1200 15:45:27 INFO - PROCESS | 1928 | colorDepth:24 15:45:27 INFO - PROCESS | 1928 | Browser inner width/height: 1024/689 15:45:27 INFO - PROCESS | 1928 | __metrics 15:45:27 INFO - PROCESS | 1928 | 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" 15:45:27 INFO - PROCESS | 1928 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:45:27 INFO - TEST-INFO | 1928: exit 0 15:45:27 INFO - Browser initialized. 15:45:27 INFO - Running cycle 1/1 for kraken test... 15:45:27 INFO - TEST-INFO | started process 1929 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmp66OJXT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:45:40 INFO - PROCESS | 1929 | RSS: Main: 232329216 15:45:40 INFO - PROCESS | 1929 | 15:45:42 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52171/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52171/tests/kraken/driver.html?testName=audio-beat-detection) 15:45:43 INFO - PROCESS | 1929 | RSS: Main: 291094528 15:45:43 INFO - PROCESS | 1929 | 15:45:46 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52171/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52171/tests/kraken/driver.html?testName=audio-dft) 15:45:47 INFO - PROCESS | 1929 | RSS: Main: 292417536 15:45:47 INFO - PROCESS | 1929 | 15:45:50 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52171/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52171/tests/kraken/driver.html?testName=audio-fft) 15:45:51 INFO - PROCESS | 1929 | RSS: Main: 383078400 15:45:51 INFO - PROCESS | 1929 | 15:45:53 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52171/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52171/tests/kraken/driver.html?testName=audio-oscillator) 15:45:53 INFO - PROCESS | 1929 | RSS: Main: 287485952 15:45:53 INFO - PROCESS | 1929 | 15:45:56 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52171/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52171/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:45:56 INFO - PROCESS | 1929 | RSS: Main: 289677312 15:45:56 INFO - PROCESS | 1929 | 15:45:59 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52171/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52171/tests/kraken/driver.html?testName=imaging-darkroom) 15:46:00 INFO - PROCESS | 1929 | RSS: Main: 326885376 15:46:00 INFO - PROCESS | 1929 | 15:46:02 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52171/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52171/tests/kraken/driver.html?testName=imaging-desaturate) 15:46:03 INFO - PROCESS | 1929 | RSS: Main: 327802880 15:46:03 INFO - PROCESS | 1929 | 15:46:06 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52171/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52171/tests/kraken/driver.html?testName=json-parse-financial) 15:46:06 INFO - PROCESS | 1929 | RSS: Main: 324960256 15:46:06 INFO - PROCESS | 1929 | 15:46:08 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52171/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52171/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:46:09 INFO - PROCESS | 1929 | RSS: Main: 302641152 15:46:09 INFO - PROCESS | 1929 | 15:46:10 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52171/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52171/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:46:11 INFO - PROCESS | 1929 | RSS: Main: 305324032 15:46:11 INFO - PROCESS | 1929 | 15:46:13 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52171/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52171/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:46:14 INFO - PROCESS | 1929 | RSS: Main: 310276096 15:46:14 INFO - PROCESS | 1929 | 15:46:17 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52171/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52171/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:46:18 INFO - PROCESS | 1929 | RSS: Main: 324505600 15:46:18 INFO - PROCESS | 1929 | 15:46:21 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52171/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52171/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:46:21 INFO - PROCESS | 1929 | RSS: Main: 317693952 15:46:21 INFO - PROCESS | 1929 | 15:46:23 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52171/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52171/tests/kraken/driver.html?testName=ai-astar) 15:46:23 INFO - PROCESS | 1929 | RSS: Main: 360771584 15:46:23 INFO - PROCESS | 1929 | 15:46:23 INFO - PROCESS | 1929 | __start_tp_report 15:46:23 INFO - PROCESS | 1929 | _x_x_mozilla_page_load 15:46:23 INFO - PROCESS | 1929 | _x_x_mozilla_page_load_details 15:46:23 INFO - PROCESS | 1929 | |i|pagename|runs| 15:46:23 INFO - PROCESS | 1929 | |0;ai-astar;111;113;113;113;114;114;112;113;113;112 15:46:23 INFO - PROCESS | 1929 | |1;audio-beat-detection;146;113;116;183;114;113;118;140;177;100 15:46:23 INFO - PROCESS | 1929 | |2;audio-dft;184;182;183;185;185;178;183;183;180;182 15:46:23 INFO - PROCESS | 1929 | |3;audio-fft;80;59;76;115;89;62;58;59;85;59 15:46:23 INFO - PROCESS | 1929 | |4;audio-oscillator;90;72;96;69;90;100;126;75;69;92 15:46:23 INFO - PROCESS | 1929 | |5;imaging-gaussian-blur;87;84;86;84;86;84;87;87;87;85 15:46:23 INFO - PROCESS | 1929 | |6;imaging-darkroom;91;93;92;93;93;92;92;92;92;92 15:46:23 INFO - PROCESS | 1929 | |7;imaging-desaturate;81;80;81;80;82;81;83;84;81;82 15:46:23 INFO - PROCESS | 1929 | |8;json-parse-financial;55;54;54;54;55;55;57;55;55;55 15:46:23 INFO - PROCESS | 1929 | |9;json-stringify-tinderbox;66;68;77;73;73;68;69;70;70;72 15:46:23 INFO - PROCESS | 1929 | |10;stanford-crypto-aes;88;91;86;91;90;88;87;89;88;93 15:46:23 INFO - PROCESS | 1929 | |11;stanford-crypto-ccm;150;145;157;178;167;155;160;172;215;187 15:46:23 INFO - PROCESS | 1929 | |12;stanford-crypto-pbkdf2;177;176;173;173;172;174;177;172;175;177 15:46:23 INFO - PROCESS | 1929 | |13;stanford-crypto-sha256-iterative;69;67;69;66;69;91;89;93;83;66 15:46:23 INFO - PROCESS | 1929 | __end_tp_report 15:46:23 INFO - PROCESS | 1929 | __start_cc_report 15:46:23 INFO - PROCESS | 1929 | _x_x_mozilla_cycle_collect,2033 15:46:23 INFO - PROCESS | 1929 | __end_cc_report 15:46:23 INFO - PROCESS | 1929 | __startTimestamp1479253583913__endTimestamp 15:46:23 INFO - PROCESS | 1929 | 15:46:23 INFO - PROCESS | 1929 | ------- Summary: start ------- 15:46:23 INFO - PROCESS | 1929 | Number of tests: 14 15:46:23 INFO - PROCESS | 1929 | 15:46:23 INFO - PROCESS | 1929 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:0.92 (0.8%) stddev-sans-first:0.71 15:46:23 INFO - PROCESS | 1929 | Values: 111.0 113.0 113.0 113.0 114.0 114.0 112.0 113.0 113.0 112.0 15:46:23 INFO - PROCESS | 1929 | 15:46:23 INFO - PROCESS | 1929 | [#1] audio-beat-detection Cycles:10 Average:132.00 Median:129.00 stddev:28.69 (22.2%) stddev-sans-first:29.98 15:46:23 INFO - PROCESS | 1929 | Values: 146.0 113.0 116.0 183.0 114.0 113.0 118.0 140.0 177.0 100.0 15:46:23 INFO - PROCESS | 1929 | 15:46:23 INFO - PROCESS | 1929 | [#2] audio-dft Cycles:10 Average:182.50 Median:183.00 stddev:2.17 (1.2%) stddev-sans-first:2.24 15:46:23 INFO - PROCESS | 1929 | Values: 184.0 182.0 183.0 185.0 185.0 178.0 183.0 183.0 180.0 182.0 15:46:23 INFO - PROCESS | 1929 | 15:46:23 INFO - PROCESS | 1929 | [#3] audio-fft Cycles:10 Average:74.20 Median:69.00 stddev:18.68 (27.1%) stddev-sans-first:19.70 15:46:23 INFO - PROCESS | 1929 | Values: 80.0 59.0 76.0 115.0 89.0 62.0 58.0 59.0 85.0 59.0 15:46:23 INFO - PROCESS | 1929 | 15:46:23 INFO - PROCESS | 1929 | [#4] audio-oscillator Cycles:10 Average:87.90 Median:82.50 stddev:17.71 (21.5%) stddev-sans-first:18.77 15:46:23 INFO - PROCESS | 1929 | Values: 90.0 72.0 96.0 69.0 90.0 100.0 126.0 75.0 69.0 92.0 15:46:23 INFO - PROCESS | 1929 | 15:46:23 INFO - PROCESS | 1929 | [#5] imaging-gaussian-blur Cycles:10 Average:85.70 Median:86.50 stddev:1.34 (1.5%) stddev-sans-first:1.33 15:46:23 INFO - PROCESS | 1929 | Values: 87.0 84.0 86.0 84.0 86.0 84.0 87.0 87.0 87.0 85.0 15:46:23 INFO - PROCESS | 1929 | 15:46:23 INFO - PROCESS | 1929 | [#6] imaging-darkroom Cycles:10 Average:92.20 Median:92.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 15:46:23 INFO - PROCESS | 1929 | Values: 91.0 93.0 92.0 93.0 93.0 92.0 92.0 92.0 92.0 92.0 15:46:23 INFO - PROCESS | 1929 | 15:46:23 INFO - PROCESS | 1929 | [#7] imaging-desaturate Cycles:10 Average:81.50 Median:81.50 stddev:1.27 (1.6%) stddev-sans-first:1.33 15:46:23 INFO - PROCESS | 1929 | Values: 81.0 80.0 81.0 80.0 82.0 81.0 83.0 84.0 81.0 82.0 15:46:23 INFO - PROCESS | 1929 | 15:46:23 INFO - PROCESS | 1929 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:0.88 (1.6%) stddev-sans-first:0.93 15:46:23 INFO - PROCESS | 1929 | Values: 55.0 54.0 54.0 54.0 55.0 55.0 57.0 55.0 55.0 55.0 15:46:23 INFO - PROCESS | 1929 | 15:46:23 INFO - PROCESS | 1929 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:71.00 stddev:3.20 (4.5%) stddev-sans-first:2.93 15:46:23 INFO - PROCESS | 1929 | Values: 66.0 68.0 77.0 73.0 73.0 68.0 69.0 70.0 70.0 72.0 15:46:23 INFO - PROCESS | 1929 | 15:46:23 INFO - PROCESS | 1929 | [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:89.50 stddev:2.13 (2.4%) stddev-sans-first:2.22 15:46:23 INFO - PROCESS | 1929 | Values: 88.0 91.0 86.0 91.0 90.0 88.0 87.0 89.0 88.0 93.0 15:46:23 INFO - PROCESS | 1929 | 15:46:23 INFO - PROCESS | 1929 | [#11] stanford-crypto-ccm Cycles:10 Average:168.60 Median:169.50 stddev:20.79 (12.3%) stddev-sans-first:20.93 15:46:23 INFO - PROCESS | 1929 | Values: 150.0 145.0 157.0 178.0 167.0 155.0 160.0 172.0 215.0 187.0 15:46:23 INFO - PROCESS | 1929 | 15:46:23 INFO - PROCESS | 1929 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.60 Median:175.50 stddev:2.07 (1.2%) stddev-sans-first:2.00 15:46:23 INFO - PROCESS | 1929 | Values: 177.0 176.0 173.0 173.0 172.0 174.0 177.0 172.0 175.0 177.0 15:46:23 INFO - PROCESS | 1929 | 15:46:23 INFO - PROCESS | 1929 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.20 Median:76.00 stddev:11.35 (14.9%) stddev-sans-first:11.74 15:46:23 INFO - PROCESS | 1929 | Values: 69.0 67.0 69.0 66.0 69.0 91.0 89.0 93.0 83.0 66.0 15:46:23 INFO - PROCESS | 1929 | -------- Summary: end -------- 15:46:23 INFO - PROCESS | 1929 | 15:46:24 INFO - TEST-INFO | 1929: exit 0 15:46:25 INFO - TEST-OK | kraken | took 60223ms 15:46:25 INFO - SUITE-END | took 1179s 15:46:25 INFO - Completed test suite (00:19:39) 15:46:25 INFO - javascript benchmark 15:46:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2835.971640283597, 3196.9360612787746, 3221.4523530999722, 3241.416545021898, 3262.967370326296, 5386.569074474042, 5416.214648875915, 5448.972755136228, 5481.725913704318, 5522.834314970552, 4727.692699974499, 5341.572674186065, 5429.809956651508, 5553.055980483307, 5574.219609254707, 4264.765437900915, 4962.429320628138, 5073.492650734934, 5080.79676812927, 5106.795728170869, 5005.5244751748705, 5041.1178043842365, 5115.590752739772, 5121.4110377306715, 5131.179011358184, 5117.744112794364, 5125.564327032207, 5131.230315452674, 5144.536991670749, 5196.506331898464, 4984.501549845023, 5006.349174607278, 5023.899522009576, 5050.065737838475, 5077.136886729265, 4098.303288440942, 4996.300517927493, 4998.775055122528, 5011.6241281904, 5032.094223039851, 5316.840494785162, 5410.296661434028, 5445.156000819879, 5471.562275017989, 5509.531689806371, 4949.604031677493, 5837.824865254049, 5997.910031349533, 6051.394860513913, 6053.939460605382, 5461.918071228934, 5899.5870289079785, 5981.162637230791, 6038.516918646497, 6046.516278697693, 5539.639923404966, 5572.414896435897, 5576.888462230732, 5608.355039170548, 5610.102383618601, 6138.662373569497, 6167.938320616737, 6174.629522228591, 6175.505959523227, 6178.351273116258, 5684.403137670568, 5723.227364305849, 5756.194132821408, 5792.652440853562, 5799.449052340021, 5905.498032667186, 5909.438603332676, 5947.881042379215, 5993.61041532299, 5998.280206375263, 5775.855603609859, 5820.447057529613, 5822.097574875901, 5824.854378640568, 5862.325832529228, 4227.51383590891, 5791.82624521265, 5927.110933360031, 5939.3763654816485, 6005.939940600625, 4741.502142275081, 4753.857384278477, 4762.166620841339, 4764.904701905943, 4776.0, 4199.223143718422, 4251.574842515785, 4300.634446072057, 4315.3095504719095, 4316.935245971313, 5533.529649979716, 5536.390996990328, 5537.889242215214, 5541.722913854291, 5543.972280138573, 5126.384833819965, 5797.985352563369, 5979.103134529855, 6034.818955431344, 6036.788712395045, 5470.835874923759, 5485.930243602539, 5512.91730624041, 5522.420145884705, 5528.806491772769, 5133.9743301284, 5176.870578235499, 5185.9740701297005, 5188.0, 5190.403103643054, 6243.188385509855, 6254.405831446005, 6268.592541484789, 6284.4344009039405, 6296.370362963667, 5905.527557795452, 6026.90959635597, 6041.154238406714, 6056.0915862619195, 6064.757409703562, 6148.200733904564, 6151.015837465984, 6199.876002479835, 6207.6275423474735, 6208.255009398901, 5930.970345148246, 5940.405959404025, 5951.315598706205, 5953.047512397996, 5980.581359304807, 5906.852328691817, 6015.72929218195, 6053.515718742578, 6077.118817771487, 6086.056661217518, 5709.115087161496, 5716.79991200306, 5791.420857914175, 5793.0, 5811.738471768696, 5760.135979603093, 5890.558208134493, 5904.996150654313, 5917.970410148094, 5941.435563621449, 4866.05112003156, 5696.458836410535, 5711.771529138788, 5720.856978575569, 5748.051571490657, 5737.48362647347, 5825.6795876225515, 5883.264591926009, 5899.262592175978, 5905.616134951214, 5489.231507589021, 5539.335279766454, 5566.387697353207, 5631.211630371833, 5708.457696518824], "value": 5443.644345435529, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [451.6138701410293, 501.50601657367463, 507.7537394363734, 512.1114865707998, 518.1450606499278, 30347.544786828214, 32287.67712322879, 40304.59695403045, 41463.58536414635, 41483.79258103705, 42185.36721949166, 42622.78688606553, 42674.7197584073, 42770.0, 42774.93062673427, 9244.67643632473, 9403.905960940405, 9404.341696081277, 9432.292578056638, 9447.433154010747, 9278.11857873501, 9391.201747851406, 9393.483358415284, 9396.389234699756, 9420.246380289595, 9366.20387267083, 9432.858507122399, 9435.952820235889, 9445.952770236174, 9446.716598502057, 9329.95335023324, 9384.953075234649, 9395.718128456158, 9395.859062114108, 9403.341766076377, 8074.273315401583, 9267.814643707088, 9335.626574936994, 9348.158665720119, 9352.018038105969, 40276.194476110315, 40546.18907621831, 40571.188576228604, 40571.98570035743, 40584.188316233805, 3189.681031896815, 3216.485362342014, 3232.531282963957, 3408.625051244361, 3424.092615456906, 29751.404971900658, 30117.548236776467, 30586.38827223443, 31214.843925780453, 31308.373832523448, 3173.9682603173906, 3212.5984251968503, 3222.677732226782, 3240.189952511872, 3348.029071569242, 503096.0, 509001.0, 509829.0, 510367.4481627605, 510936.0, 55706.72146639322, 56147.71926140343, 56166.0, 56247.0, 56276.71861640666, 34629.480557791656, 35388.292234155684, 35453.290934181176, 60955.0, 61254.77490450166, 15765.211739412984, 16001.519954401387, 16153.838461615233, 16179.919100404659, 16209.837901620833, 12288.938555307166, 12400.255984640951, 12409.0, 12416.689582760322, 12438.440270187863, 14769.778453323208, 18775.87344759319, 18860.45383873187, 18901.015393383772, 18904.0, 6488.967555162194, 6491.156149700603, 7523.924760752322, 7758.534487930629, 7802.180771018961, 784.2199403115853, 841.6696098572809, 877.2587163846539, 956.9234461243084, 1054.8101341758404, 22400.775992240197, 23415.882920585627, 28791.56812647812, 29440.263993400335, 29645.258868528028, 846.8433339832151, 993.8608594796734, 1049.4070849969742, 1083.3878858445112, 1111.5776005118003, 14967.700645987237, 14982.925085374503, 15262.141129612868, 15295.235238238043, 15383.0, 672165.0, 678462.0, 678901.0, 681913.0, 682587.0, 57041.0, 57476.0, 57542.42457575371, 57566.0, 57696.13455798166, 1210.5218438716659, 1244.3715923458597, 1248.2011512631923, 1348.7032852772375, 1367.0772228745557, 25710.485790283714, 28585.42829143447, 31496.842515787273, 31499.370012600077, 32354.83822580872, 45080.77459612681, 53738.46261537491, 54514.18228726493, 54597.0, 54709.63225919384, 589325.0, 614951.0, 620753.0, 622845.0, 622977.0, 23510.764892350857, 24089.397765055313, 26186.0, 26321.736782631928, 26556.46887062209, 45473.772631136635, 45488.84092124274, 45556.86107847198, 46681.83295417642, 46983.590492285286, 37299.06752331105, 37415.2516949654, 37663.05842353963, 38556.0, 38674.61325386823, 31443.528347074356, 37550.43674344832, 37556.2488750218, 38705.0, 38861.80569097136, 36176.45735314025, 36634.0, 37232.0, 37549.06127346838, 37695.81152094222, 25885.741142588333, 31705.841470792497, 31963.680363196072, 32247.0, 33733.3253334927, 24538.63192052085, 24742.50514989654, 24794.380140496633, 24854.751452485965, 25088.48053428243], "value": 19350.284253723443, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.8907294202328, 362.8657396763198, 366.71029886389755, 376.3827323189967, 398.2751392465712, 14518.056326338794, 14993.550193494199, 15715.371385144581, 20205.797942020574, 20627.1749130035, 18754.624907501842, 19339.903300483515, 19479.61040779187, 19649.803501964976, 19701.21195152192, 5100.642954993143, 5353.357597088336, 5354.170103633943, 5365.865853353678, 5366.490183432587, 4527.705699129562, 5293.15309550472, 5894.616849904743, 5954.821355359324, 5964.910526342108, 5906.970465147669, 5909.556783241253, 5910.379410161936, 5923.88152236955, 5927.496162826165, 5274.446183150791, 5278.181881808307, 5307.867303317409, 5318.175682769177, 5329.387120481156, 4940.184869496528, 5159.458256883011, 5167.044096842096, 5168.741562921877, 5171.663841850268, 12926.96584273256, 14194.645133871736, 18566.90716546422, 24876.0, 24889.128880489097, 2146.152269853399, 2158.589867925089, 2172.4134483689472, 2227.1982086448866, 2384.0582969727034, 9630.855537166948, 9658.034196580356, 10155.187584993257, 10182.338148020355, 14414.207218602973, 1791.8566514678794, 1857.3220774417375, 1858.349577647826, 1884.962300753991, 1907.7901430842596, 107620.92379076187, 115534.84465155409, 120754.7547147174, 122516.0, 122916.38541807323, 8988.775280618036, 9126.954365228265, 9547.809043819223, 9779.706608801747, 10146.13757830578, 11265.817089205515, 11325.150613704005, 11847.585334513251, 12240.44917978693, 12352.44414001372, 6503.772367967098, 6598.3401659833635, 7656.540607563564, 7977.2022797719765, 8082.31300339466, 7259.983602295682, 7493.925060749431, 7952.165022672536, 8051.114377418479, 8224.712135075244, 3712.535933008374, 3766.4350347448103, 3798.9810050950123, 3855.0, 3865.4974853268895, 1886.6698327792856, 1915.7413749143686, 1920.6280243898773, 1945.8346040586425, 1961.2743284984647, 828.9378296627657, 911.5824892292417, 924.5146298193503, 970.9126178643814, 982.29274922056, 20082.69875951862, 20638.896805515877, 21351.359459216248, 21518.677219841717, 21519.78480215209, 894.2577660541734, 906.6146887572755, 909.0954500272271, 917.660465627722, 963.426761077158, 10649.893501065046, 10710.250282480307, 11069.335839849635, 11311.604093856675, 11380.658580242605, 580190.0, 584239.0, 594536.4644005222, 595870.0, 599423.0375025609, 104879.47560262303, 124371.0, 129001.35499322444, 129665.05502417471, 132353.0, 930.6044930904338, 938.4697645830084, 995.6664517386756, 1008.1732978957331, 1013.761765984993, 18569.81430185735, 19491.220351185795, 19614.90192549028, 19616.411507654793, 19636.50908727236, 36050.45924311085, 50690.493095068574, 51895.78183557936, 51916.0, 52609.736951315, 74567.0, 75989.62005189939, 78562.0, 78575.0, 79473.0, 5389.730513474232, 5747.023006089058, 6297.496200304056, 7146.678399471933, 7260.4554658399775, 12053.888205958176, 12426.316552589695, 12854.935725321313, 12988.610341689764, 13298.202107873172, 10928.50821713009, 11327.376994265065, 11372.54509819598, 11488.080953523531, 11494.54021839117, 10917.836232456679, 11071.612493563009, 11179.66461006171, 11286.548538058385, 11370.43147842588, 10802.297850639683, 11376.544938202711, 11623.418829058683, 11656.592019279284, 11752.70618234551, 8077.959610201911, 8183.79540511492, 8184.7953801155445, 8230.382721295808, 8236.83526329482, 9388.483633400228, 9795.9020409795, 10899.618513351994, 10949.83575246356, 10982.450877455936], "value": 9058.578333705327, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1225.994684358825, 1495.45415923188, 1508.4720347878242, 1690.8224636413177, 1871.5601833569117, 7301.890471642923, 7891.408144389172, 7976.162502937188, 8370.121137280574, 8387.496750194992, 8225.712100076484, 8250.504969701822, 8309.127541608119, 8389.37079719022, 8394.748157555283, 2288.324944141474, 2333.9066437342485, 2338.1816364272454, 2338.3569518382496, 2338.684277622516, 2316.9652455213186, 2355.729091154522, 2372.5966585680476, 2375.1449478187837, 2375.572396968545, 2315.0855412112205, 2318.5594737, 2342.8711420871846, 2343.1330407749156, 2347.4600841806396, 2295.185209250709, 2302.297799171252, 2327.4871333633105, 2330.498942727305, 2344.0, 2320.0951628864755, 2343.94140146496, 2349.8825058746993, 2352.5059737455153, 2353.682252895854, 8269.751907442786, 8419.915800841974, 8430.32557395407, 8430.578471076484, 8440.366972477088, 4345.84789532368, 5038.067957427887, 5207.9479205207845, 5213.2701421800975, 5226.5818734501145, 3465.4455287154187, 3540.5928318243473, 3559.48387483816, 3559.768615040014, 3560.0743806610467, 882.3735148044896, 1076.8653918260218, 1082.5561519776932, 1721.1050253868043, 1752.9298828046863, 10886.945565272203, 10940.945295273552, 11025.503852326585, 11025.897410258991, 11038.061764750006, 3724.981375093107, 4209.305464598368, 4414.006848459071, 4459.643228541709, 4465.977670111693, 8716.171963663443, 8724.95637521821, 8731.083236260229, 8753.0, 8758.255548278341, 5012.147934851084, 5127.87180320495, 5133.024725302181, 5133.076046311625, 5135.204043373283, 4057.4522439470884, 4261.97869010653, 4420.093880754438, 4441.022974945507, 4757.619390448755, 3560.092176495029, 3592.946105808415, 3663.853445862189, 3669.486271921933, 3680.5583330000572, 1137.9317240965404, 1143.1312202725987, 1147.6040765935907, 1156.3408856951457, 1161.7386088130104, 787.7833595761211, 854.8888644476178, 877.9604917778715, 928.9535523223811, 935.6257497001254, 5557.749901254453, 5663.716814159276, 5748.39641837601, 5767.798127065533, 6051.243594550681, 828.3000864269683, 847.1993965702352, 871.107115206918, 912.7723212279474, 913.3332667152882, 3308.6035658729324, 3581.516495273157, 3693.409054551259, 3852.499175107218, 3952.3676211805973, 9789.412635241908, 10291.125254353314, 10317.742056448498, 10317.84523232152, 10326.48367581633, 10265.435401053013, 10275.7431064224, 10279.074883260393, 10280.537375818107, 10296.742581435374, 7733.7679869604, 7848.175941526171, 7851.725189618336, 8025.598720063974, 8030.196980301923, 5585.636933599303, 5661.122526008476, 5698.914516282342, 5770.769169233184, 5805.680687562056, 9319.021502742115, 9492.099885361167, 9529.332946693665, 9555.761105972406, 9594.376365536218, 9548.474833883925, 9599.088086631758, 9683.757906052406, 9718.173955213602, 9806.852897206405, 6711.0940023096255, 6817.965910170417, 6845.520813543004, 6891.104156459628, 6897.7240910363025, 7874.13384527713, 7915.525068495908, 7996.800079998046, 8014.639341229776, 8026.919730802851, 7139.8572028560175, 7246.96376518114, 7253.202147763636, 7305.342519173088, 7379.114506259283, 7091.574505529685, 7111.431085513043, 7116.46626503004, 7155.069840920647, 7222.855542889008, 6685.164354455693, 6692.899606505809, 6771.289014653587, 6781.457483401217, 6786.76246331376, 4659.906801864012, 4831.492693267156, 4877.487863774394, 4939.901201975868, 5047.444781074152, 4827.155247831685, 4862.659613826998, 4943.134951383566, 4976.776045077908, 4992.950070499249], "value": 4420.317845032287, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.2175461169043, 300.7894473868291, 306.76685718853673, 315.0092957648196, 316.89067271791254, 4868.342773725546, 4923.359963204783, 4973.900521989558, 5124.0, 5195.662281951671, 4037.75773453593, 4160.37594360846, 4244.702870799046, 4492.663050271226, 4608.0, 3580.997320750194, 3622.0, 3848.6728628066576, 3881.3207688654516, 3930.744501607386, 3405.0125463615523, 3923.7449565778275, 3925.9214815703667, 3927.2341893330813, 3967.26605577969, 3233.8059716416974, 3393.6267010628812, 3580.3913334733156, 3714.16431302956, 3829.3681542545587, 3206.9198270043203, 3872.3997780344093, 3873.205992771475, 3896.201278737852, 3903.8438462461468, 3381.5773028371455, 3390.542276792626, 3398.3543126805826, 3420.7776494527775, 3422.5379573757473, 4369.563043695637, 4996.851353917814, 5002.19964805633, 5005.74971251436, 5018.447970723218, 3624.8187590620364, 4256.935386337624, 4417.845375411845, 4445.933311000337, 4458.643308535342, 4556.29377446493, 5143.27994080829, 5328.600354973392, 5330.413654498002, 5338.973305133488, 3164.7309978651842, 3644.0, 3699.981500092509, 3702.907427314312, 3722.571904231021, 4794.256890182028, 4935.877572643762, 5085.67772379184, 5217.47825217479, 5637.280629408029, 3095.9845200773852, 3684.871029513954, 3694.8152592370275, 3697.5949139326885, 3721.14413684854, 3767.472553842464, 3778.282126395976, 3779.108981629056, 3784.4701741756176, 3788.507494025814, 3861.420786881934, 4180.979095104566, 4193.329067349209, 4205.453291072202, 4343.956560434419, 5065.480355893217, 5175.327207463006, 5363.624546281723, 5411.133159060118, 5429.538489228381, 1064.9094826939643, 1188.2810899405736, 1228.5331574001823, 1236.9814452783216, 1240.6340129661771, 732.8973943647893, 794.4121350200925, 806.9354451643854, 839.412411312084, 849.9235068843834, 4076.9388459173138, 4212.957870421256, 4890.747652810841, 4893.828715994923, 5144.485551444825, 5180.766865491062, 5568.6658800472105, 5573.3805111597485, 5574.414686457863, 5600.915986260209, 4782.163121453732, 5130.51260130287, 5134.948650513447, 5183.0, 5200.681172375582, 2370.893309801063, 2730.781537476997, 2742.5337692592307, 2825.7456828885497, 2845.979354658216, 4814.711117332971, 4836.347093142381, 4877.926831097537, 5280.445553216934, 5547.837732492521, 4524.470912688109, 5099.566536844335, 5198.466452396552, 5783.3323343123975, 5898.970505147447, 4816.638752093677, 5898.970505147447, 5953.0, 5970.641761494324, 5996.940030599638, 4971.850844474671, 4984.476629953802, 4994.775235114501, 5646.491815736604, 5648.63283886546, 4537.343869487548, 5142.228665700175, 5561.777528898799, 5573.972130139486, 5589.441055894378, 5847.298324201123, 5851.414858514115, 5855.268091488564, 5860.150278209721, 5875.970620146872, 3513.314903593877, 3755.9248815024093, 3803.6386543278345, 3820.3123437781464, 3825.69394448449, 4775.689580177277, 5480.671159730429, 5510.677437415072, 5555.805546805843, 5594.496495315441, 5412.539934105645, 5444.071722375229, 5454.918176227439, 5467.234587157722, 5475.288212532345, 5221.329174664071, 5426.810061647823, 5441.238226648352, 5454.563634909118, 5547.306586676666, 4672.014393882654, 4936.679115857458, 5340.839774806762, 5352.357717073976, 5360.391882435331, 4484.443866995781, 5156.9428267205885, 5197.480251974772, 5360.973195133999, 5391.272178255886, 4899.044686286283, 5247.291615631993, 5357.848062666545, 5386.380566234777, 5397.3523177218985], "value": 3891.9300771708054, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.903273541704, 727.8034930568743, 753.984920301594, 786.4219798448136, 792.7740593930731, 14497.130172189663, 15065.020773649705, 15103.77344339833, 15109.924450377734, 15109.924450377746, 13537.864621353783, 13684.589462316122, 13689.726205475885, 13693.726125477484, 13706.931465342685, 645.5513418174371, 670.5674839728372, 676.4960104721964, 783.5181363461459, 807.0799288810746, 817.1746535998625, 823.6952327638782, 824.2705205892798, 825.5211977053325, 826.0912995704707, 860.4837097741367, 876.8290183414236, 878.0210065776645, 878.4553576782372, 880.4145243413122, 865.3812524045275, 866.5104216117904, 867.9132086791302, 869.2003356911594, 869.5347988825948, 506.06630766236236, 519.7401299350324, 521.4160140642467, 647.2039391548375, 649.4641920415676, 11983.28100313984, 11983.88016119845, 11999.040076793923, 13173.538926137539, 13648.0, 13158.0, 13353.399097040656, 13571.321433928264, 13603.31983400826, 13626.931865340708, 11148.832767508495, 11244.550217991271, 11245.662630121027, 11507.482163302671, 11723.765524689543, 3642.1987162824134, 3648.7810731356203, 3680.907977300562, 3708.4993525873933, 3830.5211848518934, 61129.6943515284, 85901.28197436016, 86542.70185947216, 86658.56670716606, 88317.55841220752, 8807.867881981776, 10602.89397106019, 10608.098311643442, 10612.905467795768, 11013.889861101447, 20452.69320960157, 20747.273845415337, 20758.169673212902, 21053.473663158544, 21085.367438976857, 7484.700611975569, 7550.093988721279, 7625.0, 7630.923690763132, 7654.502457340366, 4146.398772178078, 4170.812313445902, 4202.075543380452, 4207.621314081686, 4235.8729238122905, 3536.823158842099, 3784.791836449022, 3787.962120378816, 3790.0524868782804, 3820.331441997639, 598.60791181776, 680.323078536859, 681.1315572644918, 696.8919817428206, 703.3248081841388, 574.0270241939955, 603.7652999615797, 606.3118360660682, 650.3139188156446, 663.9634820084942, 9286.071392860795, 9494.287928405398, 9588.0, 9591.568379422943, 9870.802583948282, 638.9201349831271, 640.2061443809642, 650.9902351464732, 653.3074940563018, 674.7874419557824, 3804.5853697302286, 4214.4099826024385, 4280.892977675583, 4286.057067445219, 4420.381146639473, 100962.0, 102513.97486025194, 103598.0, 105397.0, 106171.0, 56587.86824263492, 58365.41634583685, 59676.0, 59873.0, 74212.0, 77553.0, 78857.0, 81614.77577836218, 81924.59037704773, 82100.0, 8712.825743485222, 9121.543922803967, 9124.31567632417, 9231.261499080192, 9355.158035776813, 50300.742481438254, 50740.746296268284, 52336.476635234685, 54412.45587544074, 55505.0, 63603.6819815898, 63799.36200637934, 65261.0, 71377.0, 74672.0, 11632.18574699763, 11945.4027298633, 11951.94024029909, 12164.635060948185, 12433.502659893504, 11228.326300422, 13259.270740109387, 13272.601821945356, 13376.933115334361, 13378.531751388655, 12247.247893111997, 12319.50721971147, 12345.753084938431, 12478.87521124777, 12654.87345126537, 12260.38698065111, 12288.201266917622, 12542.122051456676, 12662.0, 12838.486460541473, 11973.940130299292, 12184.939075304921, 12461.750764984468, 12651.0, 12749.93625031869, 9976.403775395902, 10913.83629245546, 10935.125189984941, 11118.332900026024, 11279.943600281946, 9065.0, 10633.521491533054, 10951.123910087015, 10988.615398461016, 11044.33733975964], "value": 7063.556763571291, "unit": "score"}], "name": "dromaeo_css", "value": 6983.201469151948, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 113.0, 113.0, 114.0, 114.0, 112.0, 113.0, 113.0, 112.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 113.0, 116.0, 183.0, 114.0, 113.0, 118.0, 140.0, 177.0, 100.0], "value": 132.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 183.0, 185.0, 185.0, 178.0, 183.0, 183.0, 180.0, 182.0], "value": 182.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 76.0, 115.0, 89.0, 62.0, 58.0, 59.0, 85.0, 59.0], "value": 74.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 72.0, 96.0, 69.0, 90.0, 100.0, 126.0, 75.0, 69.0, 92.0], "value": 87.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 86.0, 84.0, 86.0, 84.0, 87.0, 87.0, 87.0, 85.0], "value": 85.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 92.0, 93.0, 93.0, 92.0, 92.0, 92.0, 92.0, 92.0], "value": 92.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 81.0, 80.0, 82.0, 81.0, 83.0, 84.0, 81.0, 82.0], "value": 81.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 54.0, 55.0, 55.0, 57.0, 55.0, 55.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 77.0, 73.0, 73.0, 68.0, 69.0, 70.0, 70.0, 72.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 91.0, 86.0, 91.0, 90.0, 88.0, 87.0, 89.0, 88.0, 93.0], "value": 89.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 145.0, 157.0, 178.0, 167.0, 155.0, 160.0, 172.0, 215.0, 187.0], "value": 168.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 176.0, 173.0, 173.0, 172.0, 174.0, 177.0, 172.0, 175.0, 177.0], "value": 174.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 69.0, 66.0, 69.0, 91.0, 89.0, 93.0, 83.0, 66.0], "value": 76.2, "unit": "score"}], "name": "kraken", "value": 1482.8, "alertThreshold": 2.0}]} 15:46:25 INFO - Return code: 0 15:46:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:46:25 INFO - # TBPL SUCCESS # 15:46:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:46:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:46:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:46:25 INFO - 2016-11-15 15:46:25.243 screenresolution[1933:18261] starting screenresolution argv=screenresolution get 15:46:25 INFO - 2016-11-15 15:46:25.247 screenresolution[1933:18261] Display 0: 1600x1200x32@60 15:46:25 INFO - 2016-11-15 15:46:25.253 screenresolution[1934:18264] starting screenresolution argv=screenresolution list 15:46:25 INFO - Available Modes on Display 0 15:46:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:46:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:46:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:46:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:46:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:46:25 INFO - Intel Iris: 15:46:25 INFO - Chipset Model: Intel Iris 15:46:25 INFO - Type: GPU 15:46:25 INFO - Bus: Built-In 15:46:25 INFO - VRAM (Dynamic, Max): 1536 MB 15:46:25 INFO - Vendor: Intel (0x8086) 15:46:25 INFO - Device ID: 0x0a2e 15:46:25 INFO - Revision ID: 0x0009 15:46:25 INFO - Displays: 15:46:25 INFO - Display: 15:46:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:46:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:46:25 INFO - Display Serial Number: 1600x1200 60 15:46:25 INFO - Main Display: Yes 15:46:25 INFO - Mirror: Off 15:46:25 INFO - Online: Yes 15:46:25 INFO - Rotation: Supported 15:46:25 INFO - Return code: 0 15:46:25 INFO - Running post-action listener: _resource_record_post_action 15:46:25 INFO - [mozharness: 2016-11-15 23:46:25.496638Z] Finished run-tests step (success) 15:46:25 INFO - Running post-run listener: _resource_record_post_run 15:46:25 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 11924480; Write bytes: 711998464; Read time: 155; Write time: 2072 15:46:25 INFO - TinderboxPrint: CPU usage
53.5% 15:46:25 INFO - TinderboxPrint: I/O read bytes / time
11,924,480 / 155 15:46:25 INFO - TinderboxPrint: I/O write bytes / time
711,998,464 / 2,072 15:46:25 INFO - TinderboxPrint: CPU idle
2,256.9 (46.5%) 15:46:25 INFO - TinderboxPrint: CPU system
972.9 (20.0%) 15:46:25 INFO - TinderboxPrint: CPU user
1,628.0 (33.5%) 15:46:25 INFO - TinderboxPrint: Swap in / out
402,948,096 / 0 15:46:25 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 399073792; Write bytes: 404229632; Read time: 29849; Write time: 898 15:46:25 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 11858944; Write bytes: 306146816; Read time: 153; Write time: 1161 15:46:25 INFO - Running post-run listener: _upload_blobber_files 15:46:25 INFO - Blob upload gear active. 15:46:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:46:25 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 15:46:25 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', 'Larch', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:46:25 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 Larch -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:46:26 INFO - (blobuploader) - INFO - Open directory for files ... 15:46:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:46:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:46:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:46:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:46:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:46:27 INFO - (blobuploader) - INFO - Done attempting. 15:46:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:46:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:46:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:46:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:46:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:46:28 INFO - (blobuploader) - INFO - Done attempting. 15:46:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:46:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:46:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:46:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:46:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:46:30 INFO - (blobuploader) - INFO - Done attempting. 15:46:30 INFO - (blobuploader) - INFO - Iteration through files over. 15:46:30 INFO - Return code: 0 15:46:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:46:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:46:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/af154f1a1a98fedd01a9a7e1e1ff6ad05d0036c010dd47f5929523e2ad12a5ac1708e959d101b648f2c5491daf5cf9581acf1472a1b3824268c06e5ba3786f8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/4b6f2b8fdd06b472a72925278e367a8521508360105c1f0a8596c17e4bb0cade398b42f3b39dff0320bd7e147356be36d74f5e3904ea04bbd39b28512627b970", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/ec7e7d36704bc9209b6327032fbbd5103d96644b500e380e1e2d855d356782e6c59cb82e576637004a3969594c5bc5a92e0a2c434be427297f9a7d00f8595602"} 15:46:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:46:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:46:30 INFO - Contents: 15:46:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/af154f1a1a98fedd01a9a7e1e1ff6ad05d0036c010dd47f5929523e2ad12a5ac1708e959d101b648f2c5491daf5cf9581acf1472a1b3824268c06e5ba3786f8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/4b6f2b8fdd06b472a72925278e367a8521508360105c1f0a8596c17e4bb0cade398b42f3b39dff0320bd7e147356be36d74f5e3904ea04bbd39b28512627b970", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/ec7e7d36704bc9209b6327032fbbd5103d96644b500e380e1e2d855d356782e6c59cb82e576637004a3969594c5bc5a92e0a2c434be427297f9a7d00f8595602"} 15:46:30 INFO - Running post-run listener: copy_logs_to_upload_dir 15:46:30 INFO - Copying logs to upload dir... 15:46:30 INFO - mkdir: /builds/slave/test/build/upload/logs 15:46:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.940018 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-11-15 15:46:30.911227) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-15 15:46:30.914418) ========= 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.bZXyYtAfpJ/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.v09wVbEbJV/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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/Larch/sha512/af154f1a1a98fedd01a9a7e1e1ff6ad05d0036c010dd47f5929523e2ad12a5ac1708e959d101b648f2c5491daf5cf9581acf1472a1b3824268c06e5ba3786f8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/4b6f2b8fdd06b472a72925278e367a8521508360105c1f0a8596c17e4bb0cade398b42f3b39dff0320bd7e147356be36d74f5e3904ea04bbd39b28512627b970", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/ec7e7d36704bc9209b6327032fbbd5103d96644b500e380e1e2d855d356782e6c59cb82e576637004a3969594c5bc5a92e0a2c434be427297f9a7d00f8595602"} build_url:https://queue.taskcluster.net/v1/task/dvdu9aQ6R0uWGZZ32z5uqg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010956 build_url: 'https://queue.taskcluster.net/v1/task/dvdu9aQ6R0uWGZZ32z5uqg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/af154f1a1a98fedd01a9a7e1e1ff6ad05d0036c010dd47f5929523e2ad12a5ac1708e959d101b648f2c5491daf5cf9581acf1472a1b3824268c06e5ba3786f8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/4b6f2b8fdd06b472a72925278e367a8521508360105c1f0a8596c17e4bb0cade398b42f3b39dff0320bd7e147356be36d74f5e3904ea04bbd39b28512627b970", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/ec7e7d36704bc9209b6327032fbbd5103d96644b500e380e1e2d855d356782e6c59cb82e576637004a3969594c5bc5a92e0a2c434be427297f9a7d00f8595602"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-15 15:46:30.947273) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 15:46:30.947620) ========= 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.bZXyYtAfpJ/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.v09wVbEbJV/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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.005037 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 15:46:30.995779) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-15 15:46:30.996142) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-15 15:46:30.996486) ========= ========= Total master_lag: 0.77 =========