builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0360 starttime: 1487101741.05 results: success (0) buildid: 20170214103145 builduid: ae462f40d81e42cd87c38c8854dff8fb revision: 97ce4f0843b9aa1288ddf3553efe1d0c2fd8c6a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-14 11:49:01.048390) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-14 11:49:01.048890) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-14 11:49:01.049181) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-14 11:49:01.075113) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 11:49:01.075503) ========= 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.j0KEffJXa5/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.dLHFzbA61L/Listeners TMPDIR=/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-14 11:49:01-- 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.14M=0.001s 2017-02-14 11:49:01 (8.14 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.088408 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 11:49:01.188769) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 11:49:01.189107) ========= 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.j0KEffJXa5/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.dLHFzbA61L/Listeners TMPDIR=/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/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.019765 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 11:49:01.238039) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-14 11:49:01.238457) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 97ce4f0843b9aa1288ddf3553efe1d0c2fd8c6a4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 97ce4f0843b9aa1288ddf3553efe1d0c2fd8c6a4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.j0KEffJXa5/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.dLHFzbA61L/Listeners TMPDIR=/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-14 11:49:01,250 truncating revision to first 12 chars 2017-02-14 11:49:01,250 Setting DEBUG logging. 2017-02-14 11:49:01,250 attempt 1/10 2017-02-14 11:49:01,250 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/97ce4f0843b9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-14 11:49:02,925 unpacking tar archive at: mozilla-beta-97ce4f0843b9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.941586 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-14 11:49:03.204927) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-14 11:49:03.205441) ========= script_repo_revision: 97ce4f0843b9aa1288ddf3553efe1d0c2fd8c6a4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-14 11:49:03.205892) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-14 11:49:03.206301) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-14 11:49:03.227496) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-02-14 11:49:03.227829) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.j0KEffJXa5/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.dLHFzbA61L/Listeners TMPDIR=/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/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 11:49:03 INFO - MultiFileLogger online at 20170214 11:49:03 in /builds/slave/test 11:49:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:49:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:49:03 INFO - {'append_to_log': False, 11:49:03 INFO - 'base_work_dir': '/builds/slave/test', 11:49:03 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:49:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:49:03 INFO - 'branch': 'Mozilla-Beta', 11:49:03 INFO - 'buildbot_json_path': 'buildprops.json', 11:49:03 INFO - 'config_files': ('talos/mac_config.py',), 11:49:03 INFO - 'default_actions': ('clobber', 11:49:03 INFO - 'read-buildbot-config', 11:49:03 INFO - 'download-and-extract', 11:49:03 INFO - 'populate-webroot', 11:49:03 INFO - 'create-virtualenv', 11:49:03 INFO - 'install', 11:49:03 INFO - 'run-tests'), 11:49:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:49:03 INFO - 'download_minidump_stackwalk': True, 11:49:03 INFO - 'download_symbols': 'ondemand', 11:49:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:49:03 INFO - 'tooltool.py': '/tools/tooltool.py', 11:49:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:49:03 INFO - '/tools/misc-python/virtualenv.py')}, 11:49:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:49:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:49:03 INFO - 'installer_path': 'installer.exe', 11:49:03 INFO - 'log_level': 'info', 11:49:03 INFO - 'log_name': 'talos', 11:49:03 INFO - 'log_to_console': True, 11:49:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:49:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:49:03 INFO - 'opt_config_files': (), 11:49:03 INFO - 'pip_index': False, 11:49:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:49:03 INFO - 'cmd': ('bash', 11:49:03 INFO - '-c', 11:49:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:49:03 INFO - 'enabled': True, 11:49:03 INFO - 'halt_on_failure': False, 11:49:03 INFO - 'name': 'check_screen_resolution'},), 11:49:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:49:03 INFO - 'cmd': ('bash', 11:49:03 INFO - '-c', 11:49:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:49:03 INFO - 'enabled': True, 11:49:03 INFO - 'halt_on_failure': False, 11:49:03 INFO - 'name': 'check_screen_resolution'},), 11:49:03 INFO - 'run_cmd_checks_enabled': True, 11:49:03 INFO - 'sps_profile': False, 11:49:03 INFO - 'sps_profile_interval': 0, 11:49:03 INFO - 'suite': 'dromaeojs', 11:49:03 INFO - 'system_bits': '32', 11:49:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:49:03 INFO - 'title': 't-yosemite-r7-0360', 11:49:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:49:03 INFO - 'use_talos_json': True, 11:49:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:49:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:49:03 INFO - 'work_dir': 'build'} 11:49:03 INFO - [mozharness: 2017-02-14 19:49:03.360553Z] Running clobber step. 11:49:03 INFO - Running pre-action listener: _resource_record_pre_action 11:49:03 INFO - Running main action method: clobber 11:49:03 INFO - rmtree: /builds/slave/test/build 11:49:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:49:05 INFO - Running post-action listener: _resource_record_post_action 11:49:05 INFO - [mozharness: 2017-02-14 19:49:05.206128Z] Finished clobber step (success) 11:49:05 INFO - [mozharness: 2017-02-14 19:49:05.206380Z] Running read-buildbot-config step. 11:49:05 INFO - Running pre-action listener: _resource_record_pre_action 11:49:05 INFO - Running main action method: read_buildbot_config 11:49:05 INFO - Using buildbot properties: 11:49:05 INFO - { 11:49:05 INFO - "project": "", 11:49:05 INFO - "product": "firefox", 11:49:05 INFO - "script_repo_revision": "production", 11:49:05 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 11:49:05 INFO - "repository": "", 11:49:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 11:49:05 INFO - "buildid": "20170214103145", 11:49:05 INFO - "pgo_build": "False", 11:49:05 INFO - "basedir": "/builds/slave/test", 11:49:05 INFO - "buildnumber": 8, 11:49:05 INFO - "slavename": "t-yosemite-r7-0360", 11:49:05 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 11:49:05 INFO - "platform": "yosemite_r7", 11:49:05 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:49:05 INFO - "branch": "mozilla-beta", 11:49:05 INFO - "repo_path": "releases/mozilla-beta", 11:49:05 INFO - "revision": "97ce4f0843b9aa1288ddf3553efe1d0c2fd8c6a4", 11:49:05 INFO - "stage_platform": "macosx64", 11:49:05 INFO - "builduid": "ae462f40d81e42cd87c38c8854dff8fb", 11:49:05 INFO - "slavebuilddir": "test" 11:49:05 INFO - } 11:49:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/QCtd5JFzRo2l0EA7BWXuAQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 11:49:05 INFO - Running post-action listener: _resource_record_post_action 11:49:05 INFO - [mozharness: 2017-02-14 19:49:05.212199Z] Finished read-buildbot-config step (success) 11:49:05 INFO - [mozharness: 2017-02-14 19:49:05.212340Z] Running download-and-extract step. 11:49:05 INFO - Running pre-action listener: _resource_record_pre_action 11:49:05 INFO - Running main action method: download_and_extract 11:49:05 INFO - mkdir: /builds/slave/test/build/tests 11:49:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:05 INFO - trying https://queue.taskcluster.net/v1/task/QCtd5JFzRo2l0EA7BWXuAQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 11:49:05 INFO - Downloading https://queue.taskcluster.net/v1/task/QCtd5JFzRo2l0EA7BWXuAQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 11:49:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QCtd5JFzRo2l0EA7BWXuAQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 11:49:06 INFO - Downloaded 1165 bytes. 11:49:06 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 11:49:06 INFO - Using the following test package requirements: 11:49:06 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 11:49:06 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:49:06 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 11:49:06 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:49:06 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 11:49:06 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:49:06 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:49:06 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 11:49:06 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 11:49:06 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:49:06 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 11:49:06 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:49:06 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 11:49:06 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:49:06 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 11:49:06 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:49:06 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 11:49:06 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 11:49:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QCtd5JFzRo2l0EA7BWXuAQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 11:49:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QCtd5JFzRo2l0EA7BWXuAQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 11:49:06 INFO - Fetch https://queue.taskcluster.net/v1/task/QCtd5JFzRo2l0EA7BWXuAQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 11:49:07 INFO - Http code: 200 11:49:07 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 11:49:07 INFO - x-amz-cf-id: uopqSfnQORN78QXqogqosKpjSvD8hh7tvZT1EEsbagL00jZiav-xQw== 11:49:07 INFO - x-amz-version-id: 2nRRmskXUUAzCPbHPU5_kGUVIEhs.coc 11:49:08 INFO - Expected file size: 16094061 11:49:08 INFO - Obtained file size: 16094061 11:49:14 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 11:49:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QCtd5JFzRo2l0EA7BWXuAQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 11:49:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QCtd5JFzRo2l0EA7BWXuAQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 11:49:14 INFO - Fetch https://queue.taskcluster.net/v1/task/QCtd5JFzRo2l0EA7BWXuAQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 11:49:15 INFO - Http code: 200 11:49:15 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 11:49:15 INFO - x-amz-cf-id: AvfvS_QNGA-cXUZMkfaC9j-X-ZH2_GjR9QLeJMq90iDZmTor4Oc0Lg== 11:49:15 INFO - x-amz-version-id: 2nRRmskXUUAzCPbHPU5_kGUVIEhs.coc 11:49:16 INFO - Expected file size: 16094061 11:49:16 INFO - Obtained file size: 16094061 11:49:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QCtd5JFzRo2l0EA7BWXuAQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 11:49:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QCtd5JFzRo2l0EA7BWXuAQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 11:49:22 INFO - Fetch https://queue.taskcluster.net/v1/task/QCtd5JFzRo2l0EA7BWXuAQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 11:49:23 INFO - Http code: 200 11:49:23 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 11:49:23 INFO - x-amz-cf-id: mPdU7qf0zfO-KxsiizoEvc02pnLVQ6Wb1cQIXAGe8D54e1nReyr-xA== 11:49:23 INFO - x-amz-version-id: L2hkb2j6UIoKzxOg1STWMNlXQjYG1VQ2 11:49:24 INFO - Expected file size: 14403005 11:49:24 INFO - Obtained file size: 14403005 11:49:24 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')]} 11:49:24 INFO - trying https://queue.taskcluster.net/v1/task/QCtd5JFzRo2l0EA7BWXuAQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 11:49:24 INFO - Downloading https://queue.taskcluster.net/v1/task/QCtd5JFzRo2l0EA7BWXuAQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 11:49:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QCtd5JFzRo2l0EA7BWXuAQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 11:49:32 INFO - Downloaded 82109974 bytes. 11:49:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QCtd5JFzRo2l0EA7BWXuAQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 11:49:32 INFO - mkdir: /builds/slave/test/properties 11:49:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:49:32 INFO - Writing to file /builds/slave/test/properties/build_url 11:49:32 INFO - Contents: 11:49:32 INFO - build_url:https://queue.taskcluster.net/v1/task/QCtd5JFzRo2l0EA7BWXuAQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 11:49:33 INFO - Running post-action listener: _resource_record_post_action 11:49:33 INFO - Running post-action listener: set_extra_try_arguments 11:49:33 INFO - [mozharness: 2017-02-14 19:49:33.381158Z] Finished download-and-extract step (success) 11:49:33 INFO - [mozharness: 2017-02-14 19:49:33.381296Z] Running populate-webroot step. 11:49:33 INFO - Running pre-action listener: _resource_record_pre_action 11:49:33 INFO - Running main action method: populate_webroot 11:49:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:49:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:49:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:49:33 INFO - '--tppagecycles', 11:49:33 INFO - '7'], 11:49:33 INFO - 'tests': ['tsvgm']}}, 11:49:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:49:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:49:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:49:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:49:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:49:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:49:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:33 INFO - 'talos_options': ['--disable-e10s'], 11:49:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:49:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:49:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:33 INFO - 'talos_options': ['--disable-e10s'], 11:49:33 INFO - 'tests': ['damp', 'tps']}, 11:49:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:33 INFO - 'tests': ['damp', 'tps']}, 11:49:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:49:33 INFO - 'tests': ['dromaeo_dom']}, 11:49:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:49:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:49:33 INFO - 'tests': ['basic_compositor_video']}, 11:49:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:49:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:49:33 INFO - 'tests': ['a11yr', 11:49:33 INFO - 'ts_paint', 11:49:33 INFO - 'tpaint', 11:49:33 INFO - 'sessionrestore', 11:49:33 INFO - 'sessionrestore_no_auto_restore', 11:49:33 INFO - 'tabpaint']}, 11:49:33 INFO - 'other-e10s': {'tests': ['a11yr', 11:49:33 INFO - 'ts_paint', 11:49:33 INFO - 'tpaint', 11:49:33 INFO - 'sessionrestore', 11:49:33 INFO - 'sessionrestore_no_auto_restore', 11:49:33 INFO - 'tabpaint']}, 11:49:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:49:33 INFO - 'ts_paint', 11:49:33 INFO - 'tpaint', 11:49:33 INFO - 'sessionrestore', 11:49:33 INFO - 'sessionrestore_no_auto_restore', 11:49:33 INFO - 'tabpaint']}, 11:49:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:49:33 INFO - 'ts_paint', 11:49:33 INFO - 'tpaint', 11:49:33 INFO - 'sessionrestore', 11:49:33 INFO - 'sessionrestore_no_auto_restore', 11:49:33 INFO - 'tabpaint']}, 11:49:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:49:33 INFO - 'tests': ['a11yr', 11:49:33 INFO - 'ts_paint', 11:49:33 INFO - 'tpaint', 11:49:33 INFO - 'sessionrestore', 11:49:33 INFO - 'sessionrestore_no_auto_restore', 11:49:33 INFO - 'tabpaint']}, 11:49:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:49:33 INFO - 'tests': ['a11yr', 11:49:33 INFO - 'ts_paint', 11:49:33 INFO - 'tpaint', 11:49:33 INFO - 'sessionrestore', 11:49:33 INFO - 'sessionrestore_no_auto_restore', 11:49:33 INFO - 'tabpaint']}, 11:49:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:49:33 INFO - 'tests': ['tsvgx', 11:49:33 INFO - 'tsvgr_opacity', 11:49:33 INFO - 'tart', 11:49:33 INFO - 'tscrollx', 11:49:33 INFO - 'cart']}, 11:49:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:49:33 INFO - 'tsvgr_opacity', 11:49:33 INFO - 'tart', 11:49:33 INFO - 'tscrollx', 11:49:33 INFO - 'cart']}, 11:49:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:33 INFO - 'talos_options': ['--disable-e10s'], 11:49:33 INFO - 'tests': ['tp5o']}, 11:49:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:33 INFO - 'tests': ['tp5o']}, 11:49:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:33 INFO - 'talos_options': ['--disable-e10s', 11:49:33 INFO - '--xperf_path', 11:49:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:49:33 INFO - 'tests': ['tp5n']}, 11:49:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:33 INFO - 'talos_options': ['--xperf_path', 11:49:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:49:33 INFO - 'tests': ['tp5n']}}, 11:49:33 INFO - 'talos.zip': {'path': '', 11:49:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:49:33 INFO - Running post-action listener: _resource_record_post_action 11:49:33 INFO - [mozharness: 2017-02-14 19:49:33.400023Z] Finished populate-webroot step (success) 11:49:33 INFO - [mozharness: 2017-02-14 19:49:33.400151Z] Running create-virtualenv step. 11:49:33 INFO - Running pre-action listener: _resource_record_pre_action 11:49:33 INFO - Running main action method: create_virtualenv 11:49:33 INFO - Creating virtualenv /builds/slave/test/build/venv 11:49:33 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 11:49:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:49:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:49:33 INFO - Using real prefix '/tools/python27' 11:49:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:49:34 INFO - Installing distribute.............................................................................................................................................................................................done. 11:49:37 INFO - Installing pip.................done. 11:49:37 INFO - Return code: 0 11:49:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:49:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:49:37 INFO - Reading from file tmpfile_stdout 11:49:37 INFO - Output received: 11:49:37 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) 11:49:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:37 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 0x10272a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026a0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9d34a3100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10253ed30>, '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 0x1023a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102536b20>, '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.j0KEffJXa5/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.dLHFzbA61L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/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 11:49:37 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 11:49:37 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 11:49:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j0KEffJXa5/Render', 11:49:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:37 INFO - 'HOME': '/Users/cltbld', 11:49:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:37 INFO - 'LOGNAME': 'cltbld', 11:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:37 INFO - 'MOZ_NO_REMOTE': '1', 11:49:37 INFO - 'NO_EM_RESTART': '1', 11:49:37 INFO - 'PAGER': '/bin/cat', 11:49:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:37 INFO - 'PWD': '/builds/slave/test', 11:49:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:37 INFO - 'SHELL': '/bin/bash', 11:49:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dLHFzbA61L/Listeners', 11:49:37 INFO - 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/', 11:49:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:37 INFO - 'USER': 'cltbld', 11:49:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:37 INFO - 'XPC_FLAGS': '0x0', 11:49:37 INFO - 'XPC_SERVICE_NAME': '0', 11:49:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:37 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 11:49:37 INFO - Cleaning up... 11:49:37 INFO - Return code: 0 11:49:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:37 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 0x10272a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026a0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9d34a3100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10253ed30>, '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 0x1023a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102536b20>, '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.j0KEffJXa5/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.dLHFzbA61L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/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 11:49:37 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 11:49:37 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 11:49:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j0KEffJXa5/Render', 11:49:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:37 INFO - 'HOME': '/Users/cltbld', 11:49:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:37 INFO - 'LOGNAME': 'cltbld', 11:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:37 INFO - 'MOZ_NO_REMOTE': '1', 11:49:37 INFO - 'NO_EM_RESTART': '1', 11:49:37 INFO - 'PAGER': '/bin/cat', 11:49:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:37 INFO - 'PWD': '/builds/slave/test', 11:49:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:37 INFO - 'SHELL': '/bin/bash', 11:49:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dLHFzbA61L/Listeners', 11:49:37 INFO - 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/', 11:49:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:37 INFO - 'USER': 'cltbld', 11:49:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:37 INFO - 'XPC_FLAGS': '0x0', 11:49:37 INFO - 'XPC_SERVICE_NAME': '0', 11:49:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:37 INFO - Downloading/unpacking psutil>=3.1.1 11:49:37 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 11:49:37 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 11:49:37 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 11:49:37 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 11:49:37 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 11:49:37 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 11:49:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:49:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:49:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:49:41 INFO - Installing collected packages: psutil 11:49:41 INFO - Running setup.py install for psutil 11:49:41 INFO - building 'psutil._psutil_osx' extension 11:49:41 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 11:49:41 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 11:49:41 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 11:49:41 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 11:49:41 INFO - building 'psutil._psutil_posix' extension 11:49:41 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 11:49:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:49:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:49:42 INFO - ^ 11:49:42 INFO - 1 warning generated. 11:49:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 11:49:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:49:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:49:42 INFO - Successfully installed psutil 11:49:42 INFO - Cleaning up... 11:49:42 INFO - Return code: 0 11:49:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:49: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')]} 11:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49: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')]} 11:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10272a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026a0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9d34a3100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10253ed30>, '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 0x1023a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102536b20>, '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.j0KEffJXa5/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.dLHFzbA61L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/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 11:49: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:49: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 mozsystemmonitor==0.3 11:49:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j0KEffJXa5/Render', 11:49:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:42 INFO - 'HOME': '/Users/cltbld', 11:49:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:42 INFO - 'LOGNAME': 'cltbld', 11:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:42 INFO - 'MOZ_NO_REMOTE': '1', 11:49:42 INFO - 'NO_EM_RESTART': '1', 11:49:42 INFO - 'PAGER': '/bin/cat', 11:49:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:42 INFO - 'PWD': '/builds/slave/test', 11:49:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:42 INFO - 'SHELL': '/bin/bash', 11:49:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dLHFzbA61L/Listeners', 11:49:42 INFO - 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/', 11:49:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:42 INFO - 'USER': 'cltbld', 11:49:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:42 INFO - 'XPC_FLAGS': '0x0', 11:49:42 INFO - 'XPC_SERVICE_NAME': '0', 11:49:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:49: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 11:49: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 11:49: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 11:49: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 11:49: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 11:49: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 11:49:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:49:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:49:45 INFO - Installing collected packages: mozsystemmonitor 11:49:45 INFO - Running setup.py install for mozsystemmonitor 11:49:45 INFO - Successfully installed mozsystemmonitor 11:49:45 INFO - Cleaning up... 11:49:45 INFO - Return code: 0 11:49:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:49: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')]} 11:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49: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')]} 11:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10272a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026a0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9d34a3100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10253ed30>, '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 0x1023a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102536b20>, '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.j0KEffJXa5/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.dLHFzbA61L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/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 11:49:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:49:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:49:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j0KEffJXa5/Render', 11:49:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:45 INFO - 'HOME': '/Users/cltbld', 11:49:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:45 INFO - 'LOGNAME': 'cltbld', 11:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:45 INFO - 'MOZ_NO_REMOTE': '1', 11:49:45 INFO - 'NO_EM_RESTART': '1', 11:49:45 INFO - 'PAGER': '/bin/cat', 11:49:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:45 INFO - 'PWD': '/builds/slave/test', 11:49:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:45 INFO - 'SHELL': '/bin/bash', 11:49:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dLHFzbA61L/Listeners', 11:49:45 INFO - 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/', 11:49:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:45 INFO - 'USER': 'cltbld', 11:49:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:45 INFO - 'XPC_FLAGS': '0x0', 11:49:45 INFO - 'XPC_SERVICE_NAME': '0', 11:49:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:45 INFO - Downloading/unpacking jsonschema==2.5.1 11:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:49:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:49:48 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 11:49:48 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 11:49:48 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 11:49:48 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 11:49:48 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 11:49:48 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 11:49:48 INFO - Downloading functools32-3.2.3-2.tar.gz 11:49:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:49:48 INFO - warning: no files found matching '*.txt' 11:49:48 INFO - no previously-included directories found matching 'build' 11:49:48 INFO - no previously-included directories found matching 'dist' 11:49:48 INFO - no previously-included directories found matching '.git*' 11:49:48 INFO - Installing collected packages: jsonschema, functools32 11:49:48 INFO - Running setup.py install for functools32 11:49:49 INFO - warning: no files found matching '*.txt' 11:49:49 INFO - no previously-included directories found matching 'build' 11:49:49 INFO - no previously-included directories found matching 'dist' 11:49:49 INFO - no previously-included directories found matching '.git*' 11:49:49 INFO - Successfully installed jsonschema functools32 11:49:49 INFO - Cleaning up... 11:49:49 INFO - Return code: 0 11:49:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:49: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')]} 11:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49: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')]} 11:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49: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', '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 0x10272a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026a0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9d34a3100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10253ed30>, '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 0x1023a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102536b20>, '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.j0KEffJXa5/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.dLHFzbA61L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/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 11:49: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:49: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 functools32==3.2.3-2 11:49:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j0KEffJXa5/Render', 11:49:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:49 INFO - 'HOME': '/Users/cltbld', 11:49:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:49 INFO - 'LOGNAME': 'cltbld', 11:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:49 INFO - 'MOZ_NO_REMOTE': '1', 11:49:49 INFO - 'NO_EM_RESTART': '1', 11:49:49 INFO - 'PAGER': '/bin/cat', 11:49:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:49 INFO - 'PWD': '/builds/slave/test', 11:49:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:49 INFO - 'SHELL': '/bin/bash', 11:49:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dLHFzbA61L/Listeners', 11:49:49 INFO - 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/', 11:49:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:49 INFO - 'USER': 'cltbld', 11:49:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:49 INFO - 'XPC_FLAGS': '0x0', 11:49:49 INFO - 'XPC_SERVICE_NAME': '0', 11:49:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:49:49 INFO - Cleaning up... 11:49:49 INFO - Return code: 0 11:49:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:49: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')]} 11:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49: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')]} 11:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49: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', '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 0x10272a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026a0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9d34a3100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10253ed30>, '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 0x1023a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102536b20>, '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.j0KEffJXa5/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.dLHFzbA61L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/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 11:49: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:49: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 blobuploader==1.2.4 11:49:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j0KEffJXa5/Render', 11:49:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:49 INFO - 'HOME': '/Users/cltbld', 11:49:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:49 INFO - 'LOGNAME': 'cltbld', 11:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:49 INFO - 'MOZ_NO_REMOTE': '1', 11:49:49 INFO - 'NO_EM_RESTART': '1', 11:49:49 INFO - 'PAGER': '/bin/cat', 11:49:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:49 INFO - 'PWD': '/builds/slave/test', 11:49:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:49 INFO - 'SHELL': '/bin/bash', 11:49:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dLHFzbA61L/Listeners', 11:49:49 INFO - 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/', 11:49:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:49 INFO - 'USER': 'cltbld', 11:49:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:49 INFO - 'XPC_FLAGS': '0x0', 11:49:49 INFO - 'XPC_SERVICE_NAME': '0', 11:49:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:49 INFO - Downloading/unpacking blobuploader==1.2.4 11:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:52 INFO - Downloading blobuploader-1.2.4.tar.gz 11:49:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:49:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:49: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 11:49: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 11:49: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 11:49: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 11:49: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 11:49: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 11:49:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:49:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:49: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 11:49: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 11:49: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 11:49: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 11:49: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 11:49: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 11:49:53 INFO - Downloading docopt-0.6.1.tar.gz 11:49:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:49:53 INFO - Installing collected packages: blobuploader, requests, docopt 11:49:53 INFO - Running setup.py install for blobuploader 11:49:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:49:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:49:53 INFO - Running setup.py install for requests 11:49:54 INFO - Running setup.py install for docopt 11:49:54 INFO - Successfully installed blobuploader requests docopt 11:49:54 INFO - Cleaning up... 11:49:54 INFO - Return code: 0 11:49:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:54 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')]} 11:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:54 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')]} 11:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:54 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 0x10272a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026a0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9d34a3100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10253ed30>, '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 0x1023a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102536b20>, '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.j0KEffJXa5/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.dLHFzbA61L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/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 11:49:54 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 11:49:54 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 11:49:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j0KEffJXa5/Render', 11:49:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:54 INFO - 'HOME': '/Users/cltbld', 11:49:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:54 INFO - 'LOGNAME': 'cltbld', 11:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:54 INFO - 'MOZ_NO_REMOTE': '1', 11:49:54 INFO - 'NO_EM_RESTART': '1', 11:49:54 INFO - 'PAGER': '/bin/cat', 11:49:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:54 INFO - 'PWD': '/builds/slave/test', 11:49:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:54 INFO - 'SHELL': '/bin/bash', 11:49:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dLHFzbA61L/Listeners', 11:49:54 INFO - 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/', 11:49:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:54 INFO - 'USER': 'cltbld', 11:49:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:54 INFO - 'XPC_FLAGS': '0x0', 11:49:54 INFO - 'XPC_SERVICE_NAME': '0', 11:49:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:49:54 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-1W4C0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:49:54 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-60lmLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:49:54 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-QWHC8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:49:55 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-wTOQCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:49:55 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-LU3Ss2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:49:55 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-0d1QhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:49:55 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-okoGNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:49:55 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-2PQ0KV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:49:55 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-FvHy3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:49:55 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-9Pl6Y_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:49:55 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-dC8Itl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:49:55 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-4ojBiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:49:56 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-h6bFsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:49:56 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-HxarbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:56 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-wLL4ep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:49:56 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-DX4xNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:49:56 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-YyOfne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:49:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:49:56 INFO - Running setup.py install for manifestparser 11:49:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:49:56 INFO - Running setup.py install for mozcrash 11:49:56 INFO - Running setup.py install for mozdebug 11:49:56 INFO - Running setup.py install for mozdevice 11:49:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:49:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:49:57 INFO - Running setup.py install for mozfile 11:49:57 INFO - Running setup.py install for mozhttpd 11:49:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:49:57 INFO - Running setup.py install for mozinfo 11:49:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:49:57 INFO - Running setup.py install for mozInstall 11:49:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:49:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:49:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:49:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:49:57 INFO - Running setup.py install for mozleak 11:49:57 INFO - Running setup.py install for mozlog 11:49:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:49:58 INFO - Running setup.py install for moznetwork 11:49:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:49:58 INFO - Running setup.py install for mozprocess 11:49:58 INFO - Running setup.py install for mozprofile 11:49:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:49:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:49:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:49:58 INFO - Running setup.py install for mozrunner 11:49:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:49:58 INFO - Running setup.py install for mozscreenshot 11:49:58 INFO - Running setup.py install for moztest 11:49:58 INFO - Running setup.py install for mozversion 11:49:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:49:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:49:59 INFO - Cleaning up... 11:49:59 INFO - Return code: 0 11:49:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:00 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 0x10272a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026a0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9d34a3100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10253ed30>, '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 0x1023a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102536b20>, '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.j0KEffJXa5/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.dLHFzbA61L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/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 11:50:00 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 11:50:00 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 11:50:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j0KEffJXa5/Render', 11:50:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:50:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:50:00 INFO - 'HOME': '/Users/cltbld', 11:50:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:50:00 INFO - 'LOGNAME': 'cltbld', 11:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:00 INFO - 'MOZ_NO_REMOTE': '1', 11:50:00 INFO - 'NO_EM_RESTART': '1', 11:50:00 INFO - 'PAGER': '/bin/cat', 11:50:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:00 INFO - 'PWD': '/builds/slave/test', 11:50:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:50:00 INFO - 'SHELL': '/bin/bash', 11:50:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dLHFzbA61L/Listeners', 11:50:00 INFO - 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/', 11:50:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:50:00 INFO - 'USER': 'cltbld', 11:50:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:50:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:00 INFO - 'XPC_FLAGS': '0x0', 11:50:00 INFO - 'XPC_SERVICE_NAME': '0', 11:50:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:50:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:50:00 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-kpatWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:50:00 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-yFXG8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:50:00 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-axQOcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:50:00 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-MQ5bPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:50:00 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-m9P4TM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:50:00 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-takDhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:50:00 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-Q5yL_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:50:01 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)) 11:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:50:01 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-B2EhlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:50:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:50:01 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-hGSmmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:50:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:50:01 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-QhjPFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:50:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:50:01 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-2nbvkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:50:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:50:01 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-IJczwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:50:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:50:01 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-_PzbvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:50:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:50:01 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-ZTzFlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:50:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:50:01 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-RtQy23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:50:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:50:01 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-SJEN2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:50:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:50:02 INFO - Running setup.py (path:/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/pip-IAObAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:50:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:50:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:50:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:50:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:50:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:50:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:50:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:05 INFO - Downloading blessings-1.6.tar.gz 11:50:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:50:05 INFO - Installing collected packages: blessings 11:50:05 INFO - Running setup.py install for blessings 11:50:05 INFO - Successfully installed blessings 11:50:05 INFO - Cleaning up... 11:50:05 INFO - Return code: 0 11:50:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:50:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:50:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:50:05 INFO - Reading from file tmpfile_stdout 11:50:05 INFO - Current package versions: 11:50:05 INFO - blessings == 1.6 11:50:05 INFO - blobuploader == 1.2.4 11:50:05 INFO - docopt == 0.6.1 11:50:05 INFO - functools32 == 3.2.3-2 11:50:05 INFO - jsonschema == 2.5.1 11:50:05 INFO - manifestparser == 1.1 11:50:05 INFO - mozInstall == 1.12 11:50:05 INFO - mozcrash == 1.0 11:50:05 INFO - mozdebug == 0.1 11:50:05 INFO - mozdevice == 0.48 11:50:05 INFO - mozfile == 1.2 11:50:05 INFO - mozhttpd == 0.7 11:50:05 INFO - mozinfo == 0.9 11:50:05 INFO - mozleak == 0.1 11:50:05 INFO - mozlog == 3.4 11:50:05 INFO - moznetwork == 0.27 11:50:05 INFO - mozprocess == 0.23 11:50:05 INFO - mozprofile == 0.28 11:50:05 INFO - mozrunner == 6.13 11:50:05 INFO - mozscreenshot == 0.1 11:50:05 INFO - mozsystemmonitor == 0.3 11:50:05 INFO - moztest == 0.8 11:50:05 INFO - mozversion == 1.4 11:50:05 INFO - psutil == 3.1.1 11:50:05 INFO - requests == 1.2.3 11:50:05 INFO - wsgiref == 0.1.2 11:50:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:50:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10272a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026a0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9d34a3100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10253ed30>, '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 0x1023a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102536b20>, '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.j0KEffJXa5/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.dLHFzbA61L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/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 11:50:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:50:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:50:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j0KEffJXa5/Render', 11:50:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:50:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:50:05 INFO - 'HOME': '/Users/cltbld', 11:50:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:50:05 INFO - 'LOGNAME': 'cltbld', 11:50:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:05 INFO - 'MOZ_NO_REMOTE': '1', 11:50:05 INFO - 'NO_EM_RESTART': '1', 11:50:05 INFO - 'PAGER': '/bin/cat', 11:50:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:50:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:05 INFO - 'PWD': '/builds/slave/test', 11:50:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:50:05 INFO - 'SHELL': '/bin/bash', 11:50:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dLHFzbA61L/Listeners', 11:50:05 INFO - 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/', 11:50:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:50:05 INFO - 'USER': 'cltbld', 11:50:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:50:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:50:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:05 INFO - 'XPC_FLAGS': '0x0', 11:50:05 INFO - 'XPC_SERVICE_NAME': '0', 11:50:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:50:06 INFO - Cleaning up... 11:50:06 INFO - Return code: 0 11:50:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10272a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1026a0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9d34a3100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10253ed30>, '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 0x1023a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102536b20>, '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.j0KEffJXa5/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.dLHFzbA61L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/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 11:50:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:50:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:50:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j0KEffJXa5/Render', 11:50:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:50:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:50:06 INFO - 'HOME': '/Users/cltbld', 11:50:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:50:06 INFO - 'LOGNAME': 'cltbld', 11:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:06 INFO - 'MOZ_NO_REMOTE': '1', 11:50:06 INFO - 'NO_EM_RESTART': '1', 11:50:06 INFO - 'PAGER': '/bin/cat', 11:50:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:06 INFO - 'PWD': '/builds/slave/test', 11:50:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:50:06 INFO - 'SHELL': '/bin/bash', 11:50:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dLHFzbA61L/Listeners', 11:50:06 INFO - 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/', 11:50:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:50:06 INFO - 'USER': 'cltbld', 11:50:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:50:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:06 INFO - 'XPC_FLAGS': '0x0', 11:50:06 INFO - 'XPC_SERVICE_NAME': '0', 11:50:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:50:06 INFO - Cleaning up... 11:50:06 INFO - Return code: 0 11:50:06 INFO - Running post-action listener: _resource_record_post_action 11:50:06 INFO - Running post-action listener: _start_resource_monitoring 11:50:06 INFO - Starting resource monitoring. 11:50:06 INFO - [mozharness: 2017-02-14 19:50:06.445712Z] Finished create-virtualenv step (success) 11:50:06 INFO - [mozharness: 2017-02-14 19:50:06.446683Z] Running install step. 11:50:06 INFO - Running pre-action listener: _resource_record_pre_action 11:50:06 INFO - Running main action method: install 11:50:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:50:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:50:06 INFO - Reading from file tmpfile_stdout 11:50:06 INFO - Detecting whether we're running mozinstall >=1.0... 11:50:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:50:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:50:06 INFO - Reading from file tmpfile_stdout 11:50:06 INFO - Output received: 11:50:06 INFO - Usage: mozinstall [options] installer 11:50:06 INFO - Options: 11:50:06 INFO - -h, --help show this help message and exit 11:50:06 INFO - -d DEST, --destination=DEST 11:50:06 INFO - Directory to install application into. [default: 11:50:06 INFO - "/builds/slave/test"] 11:50:06 INFO - --app=APP Application being installed. [default: firefox] 11:50:06 INFO - mkdir: /builds/slave/test/build/application 11:50:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:50:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 11:50:28 INFO - Reading from file tmpfile_stdout 11:50:28 INFO - Output received: 11:50:28 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:50:28 INFO - Running post-action listener: _resource_record_post_action 11:50:28 INFO - [mozharness: 2017-02-14 19:50:28.782314Z] Finished install step (success) 11:50:28 INFO - [mozharness: 2017-02-14 19:50:28.782473Z] Running run-tests step. 11:50:28 INFO - Running pre-action listener: _resource_record_pre_action 11:50:28 INFO - Running main action method: run_tests 11:50:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:50:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:50:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:50:28 INFO - 2017-02-14 11:50:28.797 screenresolution[1896:16714] starting screenresolution argv=screenresolution get 11:50:28 INFO - 2017-02-14 11:50:28.799 screenresolution[1896:16714] Display 0: 1600x1200x32@60 11:50:28 INFO - 2017-02-14 11:50:28.805 screenresolution[1897:16717] starting screenresolution argv=screenresolution list 11:50:28 INFO - Available Modes on Display 0 11:50:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:50:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:50:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:50:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:50:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:50:29 INFO - Intel Iris: 11:50:29 INFO - Chipset Model: Intel Iris 11:50:29 INFO - Type: GPU 11:50:29 INFO - Bus: Built-In 11:50:29 INFO - VRAM (Dynamic, Max): 1536 MB 11:50:29 INFO - Vendor: Intel (0x8086) 11:50:29 INFO - Device ID: 0x0a2e 11:50:29 INFO - Revision ID: 0x0009 11:50:29 INFO - Displays: 11:50:29 INFO - Display: 11:50:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:50:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:50:29 INFO - Display Serial Number: 1600x1200 60 11:50:29 INFO - Main Display: Yes 11:50:29 INFO - Mirror: Off 11:50:29 INFO - Online: Yes 11:50:29 INFO - Rotation: Supported 11:50:29 INFO - Return code: 0 11:50:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:50:29 INFO - Python 2.7.3 11:50:29 INFO - Return code: 0 11:50:29 INFO - grabbing minidump binary from tooltool 11:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:29 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 0x10253ed30>, '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 0x1023a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102536b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:50:29 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 11:50:29 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 11:50:29 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 11:50:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:50:29 INFO - Return code: 0 11:50:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:50:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:50:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:50:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:50:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:50:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QCtd5JFzRo2l0EA7BWXuAQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0360', '--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 11:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QCtd5JFzRo2l0EA7BWXuAQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0360 --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 11:50:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j0KEffJXa5/Render', 11:50:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:50:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:50:29 INFO - 'HOME': '/Users/cltbld', 11:50:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:50:29 INFO - 'LOGNAME': 'cltbld', 11:50:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:50:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:50:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:29 INFO - 'MOZ_NO_REMOTE': '1', 11:50:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:50:29 INFO - 'NO_EM_RESTART': '1', 11:50:29 INFO - 'PAGER': '/bin/cat', 11:50:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:50:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:29 INFO - 'PWD': '/builds/slave/test', 11:50:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:50:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:50:29 INFO - 'SHELL': '/bin/bash', 11:50:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dLHFzbA61L/Listeners', 11:50:29 INFO - 'TMPDIR': '/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/', 11:50:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:50:29 INFO - 'USER': 'cltbld', 11:50:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:50:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:50:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:29 INFO - 'XPC_FLAGS': '0x0', 11:50:29 INFO - 'XPC_SERVICE_NAME': '0', 11:50:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:50:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QCtd5JFzRo2l0EA7BWXuAQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0360', '--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 11:50:29 INFO - mozversion application_buildid: 20170214103145 11:50:29 INFO - mozversion application_changeset: 97ce4f0843b9aa1288ddf3553efe1d0c2fd8c6a4 11:50:29 INFO - mozversion application_display_name: Firefox 11:50:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:50:29 INFO - mozversion application_name: Firefox 11:50:29 INFO - mozversion application_remotingname: firefox 11:50:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:50:29 INFO - mozversion application_vendor: Mozilla 11:50:29 INFO - mozversion application_version: 52.0 11:50:29 INFO - mozversion platform_buildid: 20170214103145 11:50:29 INFO - mozversion platform_changeset: 97ce4f0843b9aa1288ddf3553efe1d0c2fd8c6a4 11:50:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:50:29 INFO - mozversion platform_version: 52.0 11:50:29 INFO - using testdate: 1487101829 11:50:29 INFO - actual date: 1487101829 11:50:29 INFO - starting webserver on 'localhost:54079' 11:50:29 INFO - SUITE-START | Running 2 tests 11:50:29 INFO - TEST-START | dromaeo_css 11:50:29 INFO - operating with platform_type : mac_ 11:50:29 INFO - Initialising browser for dromaeo_css test... 11:50:29 INFO - TEST-INFO | started process 1907 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/tmpR8ogQg/profile http://localhost:54079/getInfo.html) 11:50:31 INFO - PROCESS | 1907 | __metrics Screen width/height:1600/1200 11:50:31 INFO - PROCESS | 1907 | colorDepth:24 11:50:31 INFO - PROCESS | 1907 | Browser inner width/height: 1024/689 11:50:31 INFO - PROCESS | 1907 | __metrics 11:50:32 INFO - PROCESS | 1907 | 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" 11:50:32 INFO - PROCESS | 1907 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:50:32 INFO - TEST-INFO | 1907: exit 0 11:50:32 INFO - Browser initialized. 11:50:32 INFO - Running cycle 1/1 for dromaeo_css test... 11:50:32 INFO - TEST-INFO | started process 1910 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/tmpR8ogQg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:50:45 INFO - PROCESS | 1910 | RSS: Main: 171802624 11:50:45 INFO - PROCESS | 1910 | 11:53:48 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:54079/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54079/tests/dromaeo/cssquery-ext.html) 11:53:49 INFO - PROCESS | 1910 | RSS: Main: 299905024 11:53:49 INFO - PROCESS | 1910 | 11:56:52 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:54079/tests/dromaeo/cssquery-ext.html (next: http://localhost:54079/tests/dromaeo/cssquery-jquery.html) 11:56:53 INFO - PROCESS | 1910 | RSS: Main: 298975232 11:56:53 INFO - PROCESS | 1910 | 11:59:55 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:54079/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54079/tests/dromaeo/cssquery-mootools.html) 11:59:56 INFO - PROCESS | 1910 | RSS: Main: 275804160 11:59:56 INFO - PROCESS | 1910 | 12:02:58 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:54079/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54079/tests/dromaeo/cssquery-prototype.html) 12:02:59 INFO - PROCESS | 1910 | RSS: Main: 274780160 12:02:59 INFO - PROCESS | 1910 | 12:06:02 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:54079/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54079/tests/dromaeo/cssquery-yui.html) 12:06:03 INFO - PROCESS | 1910 | RSS: Main: 262082560 12:06:03 INFO - PROCESS | 1910 | 12:09:06 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:54079/tests/dromaeo/cssquery-yui.html (next: http://localhost:54079/tests/dromaeo/cssquery-dojo.html) 12:09:06 INFO - PROCESS | 1910 | RSS: Main: 450482176 12:09:06 INFO - PROCESS | 1910 | 12:09:06 INFO - PROCESS | 1910 | __start_tp_report 12:09:06 INFO - PROCESS | 1910 | _x_x_mozilla_page_load 12:09:06 INFO - PROCESS | 1910 | _x_x_mozilla_page_load_details 12:09:06 INFO - PROCESS | 1910 | |i|pagename|runs| 12:09:06 INFO - PROCESS | 1910 | |0;dojo.html;3399.3201359728055;3407.642197569255;3419.4870769384606;3439.363717712222;3496.230829217573;5692.288463942007;5710.114932185518;5730.111832665933;5742.799002034924;5757.021306377916;5658.886822263552;5737.971310143444;5744.454276843703;5749.281339832521;5781.913271300934;5220.164773636219;5242.659227150242;5276;5287.233351164098;5334.919976200341;5230.92153617696;5231.293775340338;5243.2659427680155;5321.36143662761;5351.812686555972;5052.8484145475695;5070.264811602316;5117.667351622133;5343.412224655285;5348.197770334442;5283.260343551887;5305.230741542455;5306.8407947761625;5308.416074231832;5344.812931547377;5177.948220517785;5303.522682958553;5312.734363281859;5329.040772660919;5343.278657381243;5600.327960644708;5627.662340259557;5659.122835960433;5774.422557744234;5779.393163717791;6124.480006369302;6129.7981007102635;6136.877262454771;6194.4115309045565;6215.56491045627;6225.8132256032395;6265.342139075377;6266.968665156645;6273.215848018997;6275.341089185616;5648.293963254593;5727.656340619493;5804.2744656917885;5824.440551087098;5846.1523079153285;6202.81391558254;6245.18812554365;6247.437730604177;6257;6264.1856558648;6112.480439162721;6138.14066030756;6162.476189523941;6165.10605962133;6173.506119510428;6128.78549250783;6147.493864003348;6264.718087686065;6274.309825919146;6284.088807122942;6095.238095238095;6137.297691397268;6148.616561273678;6148.770245950827;6154.984427569401;6146.61701117254;6206.286277078194;6218.253809542884;6287.308396076428;6304.9281622123435;4934.259861020875;4985.775640096204;4986.850394488171;5001.924971125436;5022.723750193702;4400.625946794495;4486.12520558488;4505.121501307213;4507.774611269423;4508.256137737302;5621.353544342453;5629.7185140742795;5653.717314134276;5667.688277144714;5707.3721890592005;6266.248050234001;6277.089821975788;6281.937180628227;6291.056341548804;6296.968515157395;5605.243292155588;5716.657000579979;5730.7421166047625;5748.281464816898;5766.740496677659;5268.025415298182;5317.973410132925;5339.332583427072;5415.83752487426;5420.91868621971;6173.444390004831;6185.597936134137;6219.595726277868;6273.153124328157;6285.874282514233;5128.128218202989;6174.413430724074;6276.717547710456;6295.244570651551;6299;6161.399937128673;6171.59884607499;6214.036824292242;6217.844553886189;6262.46769024638;5165.741712914414;5174.223866420067;6091.238595175603;6129.387061293835;6134.141220229082;6254.843628909131;6259.843503912439;6263.530235232284;6269.96865015672;6292.8426789328805;4661.277501987197;6084.117802918464;6138.355472675484;6156.353582873734;6157.199564056644;4989.700617962933;5946.494547963472;6033.939660603338;6062.605930614496;6072.392760723892;5962.373950735284;5969.164316995537;5970.223870896755;5972.731227094878;5979.910301345571;6104.298005729398;6109.816705498843;6117.632942023492;6131.264248290234;6135.969320153371;5766.365699772938;5810.215620891295;5823.592348535732;5862.237909071964;5959 12:09:06 INFO - PROCESS | 1910 | |1;ext.html;463.9907201855963;464.6538328944936;490.5903570518617;516.4835164835165;555.4473299067429;30825.22936926578;40123.39814902775;41527.792361038155;41760.95597610057;43374.78312608432;42109;42455.78772106143;42845.57154428455;43004.924876878096;43091.56908430922;8812.38313318068;8993.190612844843;9419.387739796926;9582.712518624452;9593.47235902025;10059.849102263435;11292.322460652345;11569.595064172756;11602.825957610643;11825.940870295679;11574.594889178881;11585.42072896356;11653.883461165407;11663.183577149603;11663.475143618514;11616.419179041015;11667.766644667145;11669.533218671286;11679.124065695021;11684.70788230301;11408.486618102123;11500.942495287554;11515.481803318871;11533.308001519852;11533.653990380219;40381.192376152314;40529.79735101335;40576.797116014524;40662;40682.79658601688;3203.2312245061016;3315.784474009182;3430.519727238189;3720.9441858372147;3951.8616848410456;28475.010123936896;29541.818327266883;29602.555961660593;30653.69346306553;31354.05937821869;3257.9185520361943;3284.5894263217097;3314.7182489488423;3406.625271220164;3411.300683359905;495841;500137;500267;500659;500949;34765;57321;57486.42513574894;57560.424395756345;57591.712041439525;34597.65402345944;36702;36749.26501469956;36755.081122971606;36755.89732308035;14735.92632036833;14937.850621493862;14940.850591494163;14959.326830292663;14961.850381496046;11306.321620702784;11493.252938558968;12293.0780191486;12418.56535021288;12499.50001999928;7991.360691144694;8012.559309237931;8022.839543209103;8079.151689072681;8100.513969161869;3256.413845507784;3270.7546933980047;3282.0646115856866;3300.5214243934497;3302.752293577991;896;975.6292608808608;992.270681049428;1021.6066814276558;1041.239894876729;30187.396252074836;30307.93922212712;30843;30958.916437925014;30991.845040774653;990.7869807991317;1035.177034257767;1078.347599702169;1084.8535447714457;1137.4767606900919;15026;15582.532524024298;15611;15769.842301577068;15923.964942278715;599309;611431;611521;611804;613020;47159.764201178776;48545.5145448541;48714.78213044702;48856.511434885906;48876.7556162224;1229.7724920889664;1259.924404535731;1327.794191900257;1339.1028011232497;1383.9377228024764;29768;31123.377532448772;31948.68051319457;32430;32675.509867352484;58115.70942145262;58696;58716.412835872805;58927;59079.70460147672;508255;512440;512525;513422;513857;24304.878475607507;24463.877680611484;24469.388265292797;26554.203373898814;27558.448831022866;38397;43761.78119109384;46448.53551464442;47236.7638161807;47703.52296476991;32632.34735305328;33955.32089358248;35909.820450898624;37841;39204.80397598108;38705.806470967465;38980.025499362746;39039.80480097581;39188.6081139185;39330.230139643216;32902.506462402605;33334.83332583419;38827.80586097051;39841;39894.2021159581;33942.490862637576;34514.482282765275;35303;35367.646323536435;35395;25678.358041049123;25871.094511692;25985.350366240997;26123.801586073663;26382 12:09:06 INFO - PROCESS | 1910 | |2;jquery.html;329.64233806320146;332.3187465695325;354.4506015675702;387.7421514692729;409.39614069247864;19500.122494487747;20221.090050947707;20648.587028259426;21284.148634054658;21500.354989350304;19881;19966;20330.881801500913;20374.796252037475;20547.972601369947;4721.3390125382475;5778.768849246025;5949.048152295633;6034.8793024139495;6038.094285857134;4288.506821715496;4509.729416235036;4513.232750432434;5874.853128671796;5968.253968253968;4408.669349798762;4522.841700540482;4536.478304994918;4544.977275113636;4606.97696511517;4516.2548179550495;6048.939510604881;6391.936080639227;6640.103586015898;6646.069550262967;5562.86092847678;5748.683822389767;5791.420857914217;5796.623219490762;5817.680027598481;25267.20057161557;25351;25399.746002539923;25709.35726606831;25796.742032579623;2220.611393006234;2335.9649605255763;2339.3449834046323;2401;2601.2846467221475;15016.624584385369;15544.76682849758;15716.842831571652;15983.920080399523;16400.343986240536;1888.9149988250563;1891.9688769620452;1902.9238830446766;1912.1490936533248;1950.3368854589507;104716;113067.86932130739;115319;130214.99999999905;132861;11271.492782824793;11549.307041577533;11592.072634189244;11720.179587428798;11898.821517677241;14739.778903316459;14795;14803.407863685547;14813.185274809774;14817.62955926089;8314.251717345467;8586.656533738706;8588.957055214683;8678;8720.12798720123;8409.528332541902;8417.873731894026;8422.915770842214;8568;8596.570171491401;4533.478649955231;4617.861464156081;4634.980304333041;4678.941265843018;4704.482506924235;1760.2958816473513;1859.3492277702696;1926.6532024235491;1934.7291379206922;1972.5364539333245;831.2975535672347;851.3870013590205;871.2463718883247;948.393028461785;1001.6594357918343;20212.797872021092;21751.67372489414;21752.782472175393;21859.344219673436;21976.45058873541;911.2527727263713;933.143045339769;947.5262368815593;948.374073111743;984.2175470500969;10765;11206.271592346471;11260.268082574607;11385.601503947322;11389.3166410014;597018;603604;606453;627407;630711.8464407648;129358;129710;130233;134898;136274.3186284062;921.2952091649893;957.6265256549951;965.2712202287369;967.1972263021676;970.6166064404662;17926.5518362042;18839.058047097864;19179;19230.230790768772;19238.326658566883;51593.48406515887;52204.47795521996;55203.72398137984;55361;57092;63389;75258.24741752513;77693;78639.21360786319;78923.21076789159;7906.248906353887;8110.391720621095;8326.084130745734;8385.874211886705;8526.317894568543;12381.75236495283;12848.229106253655;13199.538016169388;13246.867531324564;13540.322983850965;10239.436830974368;11099.944500277446;11306.03900658072;11416.257943233662;11421.486033128363;9756.951215243878;11091.44542772842;11288.548458061914;11328.35561729454;11526.538938442704;11477.827832582685;11485.425728713364;11556.479958401724;11778.882211177779;11847.407629618312;8129.227723366271;8244.54654993957;8557.101504341954;8572.228499435081;8625.741227763177;10970.890291097307;11056.170787191153;11421.771564568497;11511.597094101666;11539.249948753304 12:09:06 INFO - PROCESS | 1910 | |3;mootools.html;1346.5287149497683;1485.2796393749034;1509.924503774811;1668.9165541722919;1820.2809890093406;7607.391408687306;8027.678892844287;8029.317508011826;8045.436819422643;8048.758537243892;8169.428140030201;8445.197706217914;8448.704295349664;8539.743807685763;8568.614412351444;2088.227355878327;2375.406148462884;2399.8080153587757;2403.9639405408934;2404.9639255411184;2364.420716924356;2394.7485514021037;2417.55275274074;2420.2739178246457;2423.103451722865;2261.7851304126084;2273.6589511573316;2285.748567657556;2295.5638428698576;2296.9310920672406;2334.7781960713705;2335.6262997920335;2366.6450032495177;2372.8932198050957;2378.452955820171;1947.51312171957;2340.8010319122895;2385.1651921827397;2401.11158871217;2404.8576925960206;8481.151884811532;8556.871646925301;8557;8567.443116197428;8569.871451928164;5039.949600503985;5058.671186372874;5209.400918894337;5211.348581427322;5242.135047717122;3357.345317663057;3468.809215493147;3589.4974703541525;3592.8742494012586;3605.441156620728;1060.7719340341787;1082.5561519776932;1091.4488183467377;1113.2263077161376;1115.7656892052678;10919.836202456969;11049.392283424408;11165.497552610152;11166;11171.776564468664;4613.700109492872;4651.720896746206;4751.144793937125;4769.332293478916;4770.594499467515;8566.871496927552;9586.233101351874;9590.568424420917;9591.856122158173;9596.040395960348;5265.131253343156;5265.947340526623;5271.578273738169;5273.34083239595;5277.155655095166;4242.854429304132;4308.289132293136;4334.349847522897;4669.673122881366;4741.099191153669;3840.327942610032;3844.692424606025;3931.567527571965;3978.6021397860563;3996.980015099906;1251.1179618369029;1273.7452509498137;1275.5471807508386;1288.8260084888607;1290.103378152194;829.4608504472142;897.3718397122041;900.122380678846;902.4359775140537;911.093462005309;5513.338399392019;5744.224529688522;5769.596128271065;5782.479576838105;5859.94140058594;910.2444970674325;911.813078318943;914.5290175559592;917.559571405729;957.4159762544842;3706.4625629283605;3723.7765734056043;3753.793541355252;3794.4118661607495;3840.539135303781;9944.850827237597;10239.334443261165;10323.380597164194;10324.328918620266;10336.638217662347;10278.280520363503;10284.434356110485;10299.845502317472;10312.484375781181;10320;7549.0941087071005;7862.724804631925;8055.234752698484;8060.637271322805;8079.990001249844;5525.557955363481;5623.831285061455;5849.766009359748;5858.326292476419;5873.2658417697785;7712.383009359126;9298.442093474414;9492.382995105296;9516.095970882756;9638.180754635934;8316.209960053786;9593.952030239805;9724.416535007922;9785.755356116155;9799.608015679292;6682.198136223684;6867.759628412981;7081.752138675121;7327.047483827068;7673.19431459711;7993.320567751806;8102.230288122619;8212.712555060543;8213.630386632496;8222.506649601042;6202.72087756043;7164.605946672983;7199.892001620085;7238.710451581877;7266.781996540112;7034.718611255493;7105.50261481712;7128.6792094356915;7186.748463803742;7308.976743255842;5821.592488525763;6630.30381809903;6713;6794.83012924661;6799.694013769491;4672.229082201398;4760.880977975578;4870.439899411613;4915.705057696549;4959.677620954626;4838.588719958702;4863.2461968394955;4992.850214493571;4999.600031997505;5001.349824522788 12:09:06 INFO - PROCESS | 1910 | |4;prototype.html;292.8418653926881;300.9307859192386;306.6917747663598;307.96458407283154;308.6866830167381;4227.660148482699;4422.977885110578;5243.449437809028;5313.681179129255;5373.838784836456;4500;5007.198848184291;5121.795128194877;5153.201253805657;5274.441895680592;3373.8650453981813;3422.469517224828;3996.582067848953;4064.654504367132;4098.8360465581345;4043.1913617276514;4056.8377264909514;4066.031796788346;4087.3460246360587;4091.3021096245025;3522.559680039995;3625.6918161956264;3650.6349365063547;4014.7390419622775;4028.8791336259815;3445.500402441632;3654.9086272843124;3694.9815250923843;4069;4078.347464405681;2958.881644734208;3273.461473107636;3519.243362677011;3529.4705794130828;3530.541029666127;5124.538791508782;5151.562117220041;5171.922421163686;5173.275741396207;5190.351206099238;4049.6760259179196;4571.58855702985;4614.13923367511;4618.145643056046;4624.237000894848;5170.508801663836;5505.421930697299;5524.58565607581;5527.281453411071;5535.25274087997;3877.9030524236837;3879.9612003879884;3892.6496615304477;3895.454636350885;3895.7272990890647;5342.385625653022;5593.440655934414;5775.249217601685;5780.942190578083;5828.2131912191735;3465.4455287153933;3622.836972336251;3787.2046870157023;3821.904452388657;3823.923521529554;3895.24042811649;3898.142408670088;3899.2981263372867;3902.70729695274;3927.8821635350414;3780.8865734028022;4211.599898009684;4491.393661855608;4564.109998550317;4564.748938808398;5239.790408383698;5514.641548299428;5553.583481238923;5562.608078526273;5575.191597218381;1152.0035169578255;1179.097990037622;1189.822076144628;1247.2516490105863;1279.5393658283197;776.9611519424006;818.5675068629897;832.4963397144761;843.4138273899581;844.2359664503634;4379.759113248802;4401.261501706808;4590.862274131781;4790.185668436374;4845.964694828181;5732.627379220337;5747.798827041033;5758.992176369119;5762.971185144047;5791.739371728282;4985.252212168131;5144.408393034849;5200.739963001834;5230.843074707765;5236.0575096483;2499.6500489931423;2740.7533322001113;2839.716028397144;2841.545352743551;2846.8291902485503;4787.976060119677;5578;5632.9436705632415;5639.520640745583;5670.603057785998;4611.403105577588;4843.515648435128;5166.715830629276;5532.197831314437;5543.2793736814765;5212.270282160424;5669.659820410789;5683.914741278884;5687.658740475585;5706.9429305707245;4775.3763720335255;4776.355192049168;5195.454477279831;5261.105612046038;5445.918311225414;4735.502772209006;4762.9521505268785;5535.367066715248;5694.743736531949;5706.343770466284;4537.500874903824;5116.769745361393;5748.597598168088;5931.301257927719;6037.849053773691;3103.90688279352;3286.211309285802;3846.4230365445405;3863.7295389322476;3871.9352178151235;5188.4953363525665;5350.582095744709;5710.457506536873;5744.310682718101;5801.767929282782;4638.188317044436;4925.596205081534;5066.645334826527;5613.101903695389;5640.4077571856005;5245.750941737205;5325.387580428145;5524.723763811713;5642.60501764889;5656.943430565806;4997.375328083989;5234;5462.644928079662;5507.402853172535;5516.641418307797;4768.070226305837;4949.604031677529;5203.92194117081;5331.573474122139;5488.490665067138;5413.269208656939;5442.550852116484;5480.91778623313;5511.3937466879415;5525.723713814213 12:09:06 INFO - PROCESS | 1910 | |5;yui.html;618.3569088148327;768.9423293253008;799.0730752327302;808.6320724070547;815.9714409995652;13932.930335348321;15305.770413443808;15573.45492907747;15573.766393504093;15605.14171720555;12720.173188742725;13810.72378552431;13833.239171845544;13995.650108747286;14021.228832414214;817.8282560662268;818.758466252454;819.045811629451;822.2599660305713;832.8709050097244;684.9794506164823;706.7385067525023;816.4611356504709;832.309183377798;837.6398148796015;887.2325438495719;890.9910900890973;891.180114294847;891.3537685178259;892.7411050795295;887.786931136529;887.8224355129;888.6178943054484;888.7955770172864;889.5507768576892;655.8458762190882;655.9639219842907;656.0421784195081;656.4157899469476;657.6580178307302;13869.514566990107;13872.653183670389;13881.722365552734;13896.513622023282;14014.92992535041;13319.934405247654;13633.522826701117;13712;13786.448542058306;13924.791128133085;11431.705432154198;11486.770264594661;11680.474378652982;11742.530298788039;11785;3683.631636836322;3687.9631203687886;3717.9442308365396;3751.2497500499735;3853.9229215415817;95066.04933950641;100053;100247.99504009879;100294;100551.49724251404;10199.235057370726;10275.280730348804;10723.678289651323;10750.94624526888;10882.455877206108;20389;20551.794482055288;20564;20585.89707051455;20656.89671551663;7655.272749088827;7690.038745156856;7909.367250620052;7977.800554986055;8021.2379823916635;4320.697551171388;4373.518912919576;4450.532694067077;4479.350494178326;4546.976930190681;3375.8649654013566;3500.4049311617086;3501.4222653261927;3504.5794504659602;3507.14075051614;627.2034516164537;639.7824739588563;650.1061041068531;659.1859054068221;662.9138212032404;567.5261156933924;640.9262934762469;653.6372313366128;672.5225090185925;672.8755180291662;8815.382923195315;9328.720138395724;9407.811843763224;9512.524373781283;9516.666916657883;563.4250679438953;623.7660877171061;645.9761278373736;682.3551743602249;693.4279219643814;4050.1697152083752;4346.608805207483;4457.242268814244;4534.523874993144;4551.795169217393;74972;84949.20406367476;125871;126999;130376.34811826069;51444;70198;75535.24464755392;97143;98598.50700746595;84867.15132848716;88370.23259534902;88950;92484;95722;8803.339749518684;8818;8868.068852770366;8940.496660934949;8959.328050396376;50073.74963125307;51899.962000760526;59532;60583.78832423239;62682.68658656678;63972.28291029375;70802.93795592966;74907.62546187235;75197.12007199864;76860.2313976853;12265.816012759637;12359.69100772488;12603.306818124724;12730.427130778951;13210.94312454982;14145.858541414866;14402.351894164998;14407;14501.78247326312;14662.26688665541;12808.935955320163;12843.871561284268;12999.1550549214;13475.528356507475;13509.121907076009;12861.2926289055;13434.462621495031;13954.162750235018;14004.789928150882;14085.788713169106;12424.316662583644;13239.57611171658;13535.390907408993;13689.45242190341;13965.511207107702;11013.779724405307;11262.479565258585;11345.659630211107;11543.4805433754;11555.306681598795;9366.614196836983;11277.880763020938;11322.547098116313;11372.26379188364;11500.82748758786 12:09:06 INFO - PROCESS | 1910 | __end_tp_report 12:09:06 INFO - PROCESS | 1910 | __start_cc_report 12:09:06 INFO - PROCESS | 1910 | _x_x_mozilla_cycle_collect,1405 12:09:06 INFO - PROCESS | 1910 | __end_cc_report 12:09:06 INFO - PROCESS | 1910 | __startTimestamp1487102946515__endTimestamp 12:09:06 INFO - PROCESS | 1910 | 12:09:06 INFO - PROCESS | 1910 | ------- Summary: start ------- 12:09:06 INFO - PROCESS | 1910 | Number of tests: 6 12:09:06 INFO - PROCESS | 1910 | 12:09:06 INFO - PROCESS | 1910 | [#0] dojo.html Cycles:165 Average:5716.26 Median:5846.15 stddev:619.81 (10.6%) stddev-sans-first:594.46 12:09:06 INFO - PROCESS | 1910 | Values: 3399.3 3407.6 3419.5 3439.4 3496.2 5692.3 5710.1 5730.1 5742.8 5757.0 5658.9 5738.0 5744.5 5749.3 5781.9 5220.2 5242.7 5276.0 5287.2 5334.9 5230.9 5231.3 5243.3 5321.4 5351.8 5052.8 5070.3 5117.7 5343.4 5348.2 5283.3 5305.2 5306.8 5308.4 5344.8 5177.9 5303.5 5312.7 5329.0 5343.3 5600.3 5627.7 5659.1 5774.4 5779.4 6124.5 6129.8 6136.9 6194.4 6215.6 6225.8 6265.3 6267.0 6273.2 6275.3 5648.3 5727.7 5804.3 5824.4 5846.2 6202.8 6245.2 6247.4 6257.0 6264.2 6112.5 6138.1 6162.5 6165.1 6173.5 6128.8 6147.5 6264.7 6274.3 6284.1 6095.2 6137.3 6148.6 6148.8 6155.0 6146.6 6206.3 6218.3 6287.3 6304.9 4934.3 4985.8 4986.9 5001.9 5022.7 4400.6 4486.1 4505.1 4507.8 4508.3 5621.4 5629.7 5653.7 5667.7 5707.4 6266.2 6277.1 6281.9 6291.1 6297.0 5605.2 5716.7 5730.7 5748.3 5766.7 5268.0 5318.0 5339.3 5415.8 5420.9 6173.4 6185.6 6219.6 6273.2 6285.9 5128.1 6174.4 6276.7 6295.2 6299.0 6161.4 6171.6 6214.0 6217.8 6262.5 5165.7 5174.2 6091.2 6129.4 6134.1 6254.8 6259.8 6263.5 6270.0 6292.8 4661.3 6084.1 6138.4 6156.4 6157.2 4989.7 5946.5 6033.9 6062.6 6072.4 5962.4 5969.2 5970.2 5972.7 5979.9 6104.3 6109.8 6117.6 6131.3 6136.0 5766.4 5810.2 5823.6 5862.2 5959.0 12:09:06 INFO - PROCESS | 1910 | 12:09:06 INFO - PROCESS | 1910 | [#1] ext.html Cycles:180 Average:66536.87 Median:34556.07 stddev:144916.52 (419.4%) stddev-sans-first:145238.14 12:09:06 INFO - PROCESS | 1910 | Values: 464.0 464.7 490.6 516.5 555.4 30825.2 40123.4 41527.8 41761.0 43374.8 42109.0 42455.8 42845.6 43004.9 43091.6 8812.4 8993.2 9419.4 9582.7 9593.5 10059.8 11292.3 11569.6 11602.8 11825.9 11574.6 11585.4 11653.9 11663.2 11663.5 11616.4 11667.8 11669.5 11679.1 11684.7 11408.5 11500.9 11515.5 11533.3 11533.7 40381.2 40529.8 40576.8 40662.0 40682.8 3203.2 3315.8 3430.5 3720.9 3951.9 28475.0 29541.8 29602.6 30653.7 31354.1 3257.9 3284.6 3314.7 3406.6 3411.3 495841.0 500137.0 500267.0 500659.0 500949.0 34765.0 57321.0 57486.4 57560.4 57591.7 34597.7 36702.0 36749.3 36755.1 36755.9 14735.9 14937.9 14940.9 14959.3 14961.9 11306.3 11493.3 12293.1 12418.6 12499.5 7991.4 8012.6 8022.8 8079.2 8100.5 3256.4 3270.8 3282.1 3300.5 3302.8 896.0 975.6 992.3 1021.6 1041.2 30187.4 30307.9 30843.0 30958.9 30991.8 990.8 1035.2 1078.3 1084.9 1137.5 15026.0 15582.5 15611.0 15769.8 15924.0 599309.0 611431.0 611521.0 611804.0 613020.0 47159.8 48545.5 48714.8 48856.5 48876.8 1229.8 1259.9 1327.8 1339.1 1383.9 29768.0 31123.4 31948.7 32430.0 32675.5 58115.7 58696.0 58716.4 58927.0 59079.7 508255.0 512440.0 512525.0 513422.0 513857.0 24304.9 24463.9 24469.4 26554.2 27558.4 38397.0 43761.8 46448.5 47236.8 47703.5 32632.3 33955.3 35909.8 37841.0 39204.8 38705.8 38980.0 39039.8 39188.6 39330.2 32902.5 33334.8 38827.8 39841.0 39894.2 33942.5 34514.5 35303.0 35367.6 35395.0 25678.4 25871.1 25985.4 26123.8 26382.0 12:09:06 INFO - PROCESS | 1910 | 12:09:06 INFO - PROCESS | 1910 | [#2] jquery.html Cycles:180 Average:35732.18 Median:25375.37 stddev:102289.71 (403.1%) stddev-sans-first:102542.11 12:09:06 INFO - PROCESS | 1910 | Values: 329.6 332.3 354.5 387.7 409.4 19500.1 20221.1 20648.6 21284.1 21500.4 19881.0 19966.0 20330.9 20374.8 20548.0 4721.3 5778.8 5949.0 6034.9 6038.1 4288.5 4509.7 4513.2 5874.9 5968.3 4408.7 4522.8 4536.5 4545.0 4607.0 4516.3 6048.9 6391.9 6640.1 6646.1 5562.9 5748.7 5791.4 5796.6 5817.7 25267.2 25351.0 25399.7 25709.4 25796.7 2220.6 2336.0 2339.3 2401.0 2601.3 15016.6 15544.8 15716.8 15983.9 16400.3 1888.9 1892.0 1902.9 1912.1 1950.3 104716.0 113067.9 115319.0 130215.0 132861.0 11271.5 11549.3 11592.1 11720.2 11898.8 14739.8 14795.0 14803.4 14813.2 14817.6 8314.3 8586.7 8589.0 8678.0 8720.1 8409.5 8417.9 8422.9 8568.0 8596.6 4533.5 4617.9 4635.0 4678.9 4704.5 1760.3 1859.3 1926.7 1934.7 1972.5 831.3 851.4 871.2 948.4 1001.7 20212.8 21751.7 21752.8 21859.3 21976.5 911.3 933.1 947.5 948.4 984.2 10765.0 11206.3 11260.3 11385.6 11389.3 597018.0 603604.0 606453.0 627407.0 630711.8 129358.0 129710.0 130233.0 134898.0 136274.3 921.3 957.6 965.3 967.2 970.6 17926.6 18839.1 19179.0 19230.2 19238.3 51593.5 52204.5 55203.7 55361.0 57092.0 63389.0 75258.2 77693.0 78639.2 78923.2 7906.2 8110.4 8326.1 8385.9 8526.3 12381.8 12848.2 13199.5 13246.9 13540.3 10239.4 11099.9 11306.0 11416.3 11421.5 9757.0 11091.4 11288.5 11328.4 11526.5 11477.8 11485.4 11556.5 11778.9 11847.4 8129.2 8244.5 8557.1 8572.2 8625.7 10970.9 11056.2 11421.8 11511.6 11539.2 12:09:06 INFO - PROCESS | 1910 | 12:09:06 INFO - PROCESS | 1910 | [#3] mootools.html Cycles:180 Average:5497.53 Median:5134.04 stddev:3013.69 (58.7%) stddev-sans-first:3006.00 12:09:06 INFO - PROCESS | 1910 | Values: 1346.5 1485.3 1509.9 1668.9 1820.3 7607.4 8027.7 8029.3 8045.4 8048.8 8169.4 8445.2 8448.7 8539.7 8568.6 2088.2 2375.4 2399.8 2404.0 2405.0 2364.4 2394.7 2417.6 2420.3 2423.1 2261.8 2273.7 2285.7 2295.6 2296.9 2334.8 2335.6 2366.6 2372.9 2378.5 1947.5 2340.8 2385.2 2401.1 2404.9 8481.2 8556.9 8557.0 8567.4 8569.9 5039.9 5058.7 5209.4 5211.3 5242.1 3357.3 3468.8 3589.5 3592.9 3605.4 1060.8 1082.6 1091.4 1113.2 1115.8 10919.8 11049.4 11165.5 11166.0 11171.8 4613.7 4651.7 4751.1 4769.3 4770.6 8566.9 9586.2 9590.6 9591.9 9596.0 5265.1 5265.9 5271.6 5273.3 5277.2 4242.9 4308.3 4334.3 4669.7 4741.1 3840.3 3844.7 3931.6 3978.6 3997.0 1251.1 1273.7 1275.5 1288.8 1290.1 829.5 897.4 900.1 902.4 911.1 5513.3 5744.2 5769.6 5782.5 5859.9 910.2 911.8 914.5 917.6 957.4 3706.5 3723.8 3753.8 3794.4 3840.5 9944.9 10239.3 10323.4 10324.3 10336.6 10278.3 10284.4 10299.8 10312.5 10320.0 7549.1 7862.7 8055.2 8060.6 8080.0 5525.6 5623.8 5849.8 5858.3 5873.3 7712.4 9298.4 9492.4 9516.1 9638.2 8316.2 9594.0 9724.4 9785.8 9799.6 6682.2 6867.8 7081.8 7327.0 7673.2 7993.3 8102.2 8212.7 8213.6 8222.5 6202.7 7164.6 7199.9 7238.7 7266.8 7034.7 7105.5 7128.7 7186.7 7309.0 5821.6 6630.3 6713.0 6794.8 6799.7 4672.2 4760.9 4870.4 4915.7 4959.7 4838.6 4863.2 4992.9 4999.6 5001.3 12:09:06 INFO - PROCESS | 1910 | 12:09:06 INFO - PROCESS | 1910 | [#4] prototype.html Cycles:180 Average:4422.84 Median:4991.31 stddev:1372.57 (27.5%) stddev-sans-first:1340.96 12:09:06 INFO - PROCESS | 1910 | Values: 292.8 300.9 306.7 308.0 308.7 4227.7 4423.0 5243.4 5313.7 5373.8 4500.0 5007.2 5121.8 5153.2 5274.4 3373.9 3422.5 3996.6 4064.7 4098.8 4043.2 4056.8 4066.0 4087.3 4091.3 3522.6 3625.7 3650.6 4014.7 4028.9 3445.5 3654.9 3695.0 4069.0 4078.3 2958.9 3273.5 3519.2 3529.5 3530.5 5124.5 5151.6 5171.9 5173.3 5190.4 4049.7 4571.6 4614.1 4618.1 4624.2 5170.5 5505.4 5524.6 5527.3 5535.3 3877.9 3880.0 3892.6 3895.5 3895.7 5342.4 5593.4 5775.2 5780.9 5828.2 3465.4 3622.8 3787.2 3821.9 3823.9 3895.2 3898.1 3899.3 3902.7 3927.9 3780.9 4211.6 4491.4 4564.1 4564.7 5239.8 5514.6 5553.6 5562.6 5575.2 1152.0 1179.1 1189.8 1247.3 1279.5 777.0 818.6 832.5 843.4 844.2 4379.8 4401.3 4590.9 4790.2 4846.0 5732.6 5747.8 5759.0 5763.0 5791.7 4985.3 5144.4 5200.7 5230.8 5236.1 2499.7 2740.8 2839.7 2841.5 2846.8 4788.0 5578.0 5632.9 5639.5 5670.6 4611.4 4843.5 5166.7 5532.2 5543.3 5212.3 5669.7 5683.9 5687.7 5706.9 4775.4 4776.4 5195.5 5261.1 5445.9 4735.5 4763.0 5535.4 5694.7 5706.3 4537.5 5116.8 5748.6 5931.3 6037.8 3103.9 3286.2 3846.4 3863.7 3871.9 5188.5 5350.6 5710.5 5744.3 5801.8 4638.2 4925.6 5066.6 5613.1 5640.4 5245.8 5325.4 5524.7 5642.6 5656.9 4997.4 5234.0 5462.6 5507.4 5516.6 4768.1 4949.6 5203.9 5331.6 5488.5 5413.3 5442.6 5480.9 5511.4 5525.7 12:09:06 INFO - PROCESS | 1910 | 12:09:06 INFO - PROCESS | 1910 | [#5] yui.html Cycles:180 Average:20649.61 Median:4453.89 stddev:30327.09 (680.9%) stddev-sans-first:30374.86 12:09:06 INFO - PROCESS | 1910 | Values: 618.4 768.9 799.1 808.6 816.0 13932.9 15305.8 15573.5 15573.8 15605.1 12720.2 13810.7 13833.2 13995.7 14021.2 817.8 818.8 819.0 822.3 832.9 685.0 706.7 816.5 832.3 837.6 887.2 891.0 891.2 891.4 892.7 887.8 887.8 888.6 888.8 889.6 655.8 656.0 656.0 656.4 657.7 13869.5 13872.7 13881.7 13896.5 14014.9 13319.9 13633.5 13712.0 13786.4 13924.8 11431.7 11486.8 11680.5 11742.5 11785.0 3683.6 3688.0 3717.9 3751.2 3853.9 95066.0 100053.0 100248.0 100294.0 100551.5 10199.2 10275.3 10723.7 10750.9 10882.5 20389.0 20551.8 20564.0 20585.9 20656.9 7655.3 7690.0 7909.4 7977.8 8021.2 4320.7 4373.5 4450.5 4479.4 4547.0 3375.9 3500.4 3501.4 3504.6 3507.1 627.2 639.8 650.1 659.2 662.9 567.5 640.9 653.6 672.5 672.9 8815.4 9328.7 9407.8 9512.5 9516.7 563.4 623.8 646.0 682.4 693.4 4050.2 4346.6 4457.2 4534.5 4551.8 74972.0 84949.2 125871.0 126999.0 130376.3 51444.0 70198.0 75535.2 97143.0 98598.5 84867.2 88370.2 88950.0 92484.0 95722.0 8803.3 8818.0 8868.1 8940.5 8959.3 50073.7 51900.0 59532.0 60583.8 62682.7 63972.3 70802.9 74907.6 75197.1 76860.2 12265.8 12359.7 12603.3 12730.4 13210.9 14145.9 14402.4 14407.0 14501.8 14662.3 12808.9 12843.9 12999.2 13475.5 13509.1 12861.3 13434.5 13954.2 14004.8 14085.8 12424.3 13239.6 13535.4 13689.5 13965.5 11013.8 11262.5 11345.7 11543.5 11555.3 9366.6 11277.9 11322.5 11372.3 11500.8 12:09:06 INFO - PROCESS | 1910 | -------- Summary: end -------- 12:09:06 INFO - PROCESS | 1910 | 12:09:07 INFO - TEST-INFO | 1910: exit 0 12:09:07 INFO - TEST-OK | dromaeo_css | took 1117780ms 12:09:07 INFO - TEST-START | kraken 12:09:07 INFO - operating with platform_type : mac_ 12:09:07 INFO - Initialising browser for kraken test... 12:09:07 INFO - TEST-INFO | started process 1915 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/tmpDKrQrS/profile http://localhost:54079/getInfo.html) 12:09:09 INFO - PROCESS | 1915 | __metrics Screen width/height:1600/1200 12:09:09 INFO - PROCESS | 1915 | colorDepth:24 12:09:09 INFO - PROCESS | 1915 | Browser inner width/height: 1024/689 12:09:09 INFO - PROCESS | 1915 | __metrics 12:09:09 INFO - PROCESS | 1915 | 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" 12:09:09 INFO - PROCESS | 1915 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:09:10 INFO - TEST-INFO | 1915: exit 0 12:09:10 INFO - Browser initialized. 12:09:10 INFO - Running cycle 1/1 for kraken test... 12:09:10 INFO - TEST-INFO | started process 1917 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/tmpDKrQrS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:09:22 INFO - PROCESS | 1917 | RSS: Main: 167796736 12:09:22 INFO - PROCESS | 1917 | 12:09:25 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:54079/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54079/tests/kraken/driver.html?testName=audio-beat-detection) 12:09:26 INFO - PROCESS | 1917 | RSS: Main: 218132480 12:09:26 INFO - PROCESS | 1917 | 12:09:28 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:54079/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54079/tests/kraken/driver.html?testName=audio-dft) 12:09:29 INFO - PROCESS | 1917 | RSS: Main: 232058880 12:09:29 INFO - PROCESS | 1917 | 12:09:32 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:54079/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54079/tests/kraken/driver.html?testName=audio-fft) 12:09:33 INFO - PROCESS | 1917 | RSS: Main: 329412608 12:09:33 INFO - PROCESS | 1917 | 12:09:35 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:54079/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54079/tests/kraken/driver.html?testName=audio-oscillator) 12:09:35 INFO - PROCESS | 1917 | RSS: Main: 231792640 12:09:35 INFO - PROCESS | 1917 | 12:09:37 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:54079/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54079/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:09:38 INFO - PROCESS | 1917 | RSS: Main: 233029632 12:09:38 INFO - PROCESS | 1917 | 12:09:41 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:54079/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54079/tests/kraken/driver.html?testName=imaging-darkroom) 12:09:41 INFO - PROCESS | 1917 | RSS: Main: 273031168 12:09:41 INFO - PROCESS | 1917 | 12:09:44 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:54079/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54079/tests/kraken/driver.html?testName=imaging-desaturate) 12:09:45 INFO - PROCESS | 1917 | RSS: Main: 273100800 12:09:45 INFO - PROCESS | 1917 | 12:09:48 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:54079/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54079/tests/kraken/driver.html?testName=json-parse-financial) 12:09:48 INFO - PROCESS | 1917 | RSS: Main: 271826944 12:09:48 INFO - PROCESS | 1917 | 12:09:50 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:54079/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54079/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:09:50 INFO - PROCESS | 1917 | RSS: Main: 247693312 12:09:50 INFO - PROCESS | 1917 | 12:09:52 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:54079/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54079/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:09:53 INFO - PROCESS | 1917 | RSS: Main: 250318848 12:09:53 INFO - PROCESS | 1917 | 12:09:55 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:54079/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54079/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:09:56 INFO - PROCESS | 1917 | RSS: Main: 251912192 12:09:56 INFO - PROCESS | 1917 | 12:09:59 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:54079/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54079/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:09:59 INFO - PROCESS | 1917 | RSS: Main: 269246464 12:09:59 INFO - PROCESS | 1917 | 12:10:02 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:54079/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54079/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:10:03 INFO - PROCESS | 1917 | RSS: Main: 262758400 12:10:03 INFO - PROCESS | 1917 | 12:10:05 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:54079/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54079/tests/kraken/driver.html?testName=ai-astar) 12:10:05 INFO - PROCESS | 1917 | RSS: Main: 306810880 12:10:05 INFO - PROCESS | 1917 | 12:10:05 INFO - PROCESS | 1917 | __start_tp_report 12:10:05 INFO - PROCESS | 1917 | _x_x_mozilla_page_load 12:10:05 INFO - PROCESS | 1917 | _x_x_mozilla_page_load_details 12:10:05 INFO - PROCESS | 1917 | |i|pagename|runs| 12:10:05 INFO - PROCESS | 1917 | |0;ai-astar;102;113;116;115;115;115;115;113;115;116 12:10:05 INFO - PROCESS | 1917 | |1;audio-beat-detection;144;109;107;146;108;107;131;134;169;106 12:10:05 INFO - PROCESS | 1917 | |2;audio-dft;187;178;186;184;183;183;183;184;182;181 12:10:05 INFO - PROCESS | 1917 | |3;audio-fft;80;59;59;102;59;62;58;59;80;58 12:10:05 INFO - PROCESS | 1917 | |4;audio-oscillator;90;69;93;69;69;67;89;67;68;92 12:10:05 INFO - PROCESS | 1917 | |5;imaging-gaussian-blur;91;87;90;88;90;85;90;84;90;86 12:10:05 INFO - PROCESS | 1917 | |6;imaging-darkroom;95;95;95;95;103;95;95;95;95;96 12:10:05 INFO - PROCESS | 1917 | |7;imaging-desaturate;94;133;124;83;84;84;83;84;81;83 12:10:05 INFO - PROCESS | 1917 | |8;json-parse-financial;56;52;53;54;56;56;57;56;56;57 12:10:05 INFO - PROCESS | 1917 | |9;json-stringify-tinderbox;63;71;79;73;71;72;68;67;67;68 12:10:05 INFO - PROCESS | 1917 | |10;stanford-crypto-aes;81;83;81;80;83;69;89;79;76;99 12:10:05 INFO - PROCESS | 1917 | |11;stanford-crypto-ccm;136;134;136;145;143;154;141;151;195;166 12:10:05 INFO - PROCESS | 1917 | |12;stanford-crypto-pbkdf2;162;162;162;163;180;210;204;161;164;161 12:10:05 INFO - PROCESS | 1917 | |13;stanford-crypto-sha256-iterative;66;66;66;66;66;65;65;66;64;65 12:10:05 INFO - PROCESS | 1917 | __end_tp_report 12:10:05 INFO - PROCESS | 1917 | __start_cc_report 12:10:05 INFO - PROCESS | 1917 | _x_x_mozilla_cycle_collect,1914 12:10:05 INFO - PROCESS | 1917 | __end_cc_report 12:10:05 INFO - PROCESS | 1917 | __startTimestamp1487103005269__endTimestamp 12:10:05 INFO - PROCESS | 1917 | 12:10:05 INFO - PROCESS | 1917 | ------- Summary: start ------- 12:10:05 INFO - PROCESS | 1917 | Number of tests: 14 12:10:05 INFO - PROCESS | 1917 | 12:10:05 INFO - PROCESS | 1917 | [#0] ai-astar Cycles:10 Average:113.50 Median:115.00 stddev:4.17 (3.6%) stddev-sans-first:1.09 12:10:05 INFO - PROCESS | 1917 | Values: 102.0 113.0 116.0 115.0 115.0 115.0 115.0 113.0 115.0 116.0 12:10:05 INFO - PROCESS | 1917 | 12:10:05 INFO - PROCESS | 1917 | [#1] audio-beat-detection Cycles:10 Average:126.10 Median:132.50 stddev:22.10 (16.7%) stddev-sans-first:22.47 12:10:05 INFO - PROCESS | 1917 | Values: 144.0 109.0 107.0 146.0 108.0 107.0 131.0 134.0 169.0 106.0 12:10:05 INFO - PROCESS | 1917 | 12:10:05 INFO - PROCESS | 1917 | [#2] audio-dft Cycles:10 Average:183.10 Median:183.50 stddev:2.51 (1.4%) stddev-sans-first:2.24 12:10:05 INFO - PROCESS | 1917 | Values: 187.0 178.0 186.0 184.0 183.0 183.0 183.0 184.0 182.0 181.0 12:10:05 INFO - PROCESS | 1917 | 12:10:05 INFO - PROCESS | 1917 | [#3] audio-fft Cycles:10 Average:67.60 Median:59.00 stddev:14.92 (25.3%) stddev-sans-first:15.13 12:10:05 INFO - PROCESS | 1917 | Values: 80.0 59.0 59.0 102.0 59.0 62.0 58.0 59.0 80.0 58.0 12:10:05 INFO - PROCESS | 1917 | 12:10:05 INFO - PROCESS | 1917 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:79.00 stddev:11.86 (15.0%) stddev-sans-first:11.66 12:10:05 INFO - PROCESS | 1917 | Values: 90.0 69.0 93.0 69.0 69.0 67.0 89.0 67.0 68.0 92.0 12:10:05 INFO - PROCESS | 1917 | 12:10:05 INFO - PROCESS | 1917 | [#5] imaging-gaussian-blur Cycles:10 Average:88.10 Median:90.00 stddev:2.47 (2.7%) stddev-sans-first:2.39 12:10:05 INFO - PROCESS | 1917 | Values: 91.0 87.0 90.0 88.0 90.0 85.0 90.0 84.0 90.0 86.0 12:10:05 INFO - PROCESS | 1917 | 12:10:05 INFO - PROCESS | 1917 | [#6] imaging-darkroom Cycles:10 Average:95.90 Median:95.00 stddev:2.51 (2.6%) stddev-sans-first:2.65 12:10:05 INFO - PROCESS | 1917 | Values: 95.0 95.0 95.0 95.0 103.0 95.0 95.0 95.0 95.0 96.0 12:10:05 INFO - PROCESS | 1917 | 12:10:05 INFO - PROCESS | 1917 | [#7] imaging-desaturate Cycles:10 Average:93.30 Median:83.50 stddev:19.00 (22.8%) stddev-sans-first:20.15 12:10:05 INFO - PROCESS | 1917 | Values: 94.0 133.0 124.0 83.0 84.0 84.0 83.0 84.0 81.0 83.0 12:10:05 INFO - PROCESS | 1917 | 12:10:05 INFO - PROCESS | 1917 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:56.00 stddev:1.70 (3.0%) stddev-sans-first:1.79 12:10:05 INFO - PROCESS | 1917 | Values: 56.0 52.0 53.0 54.0 56.0 56.0 57.0 56.0 56.0 57.0 12:10:05 INFO - PROCESS | 1917 | 12:10:05 INFO - PROCESS | 1917 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:71.00 stddev:4.36 (6.1%) stddev-sans-first:3.84 12:10:05 INFO - PROCESS | 1917 | Values: 63.0 71.0 79.0 73.0 71.0 72.0 68.0 67.0 67.0 68.0 12:10:05 INFO - PROCESS | 1917 | 12:10:05 INFO - PROCESS | 1917 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.00 stddev:7.89 (9.6%) stddev-sans-first:8.36 12:10:05 INFO - PROCESS | 1917 | Values: 81.0 83.0 81.0 80.0 83.0 69.0 89.0 79.0 76.0 99.0 12:10:05 INFO - PROCESS | 1917 | 12:10:05 INFO - PROCESS | 1917 | [#11] stanford-crypto-ccm Cycles:10 Average:150.10 Median:148.00 stddev:18.56 (12.5%) stddev-sans-first:18.97 12:10:05 INFO - PROCESS | 1917 | Values: 136.0 134.0 136.0 145.0 143.0 154.0 141.0 151.0 195.0 166.0 12:10:05 INFO - PROCESS | 1917 | 12:10:05 INFO - PROCESS | 1917 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.90 Median:163.50 stddev:18.89 (11.6%) stddev-sans-first:19.62 12:10:05 INFO - PROCESS | 1917 | Values: 162.0 162.0 162.0 163.0 180.0 210.0 204.0 161.0 164.0 161.0 12:10:05 INFO - PROCESS | 1917 | 12:10:05 INFO - PROCESS | 1917 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:0.71 (1.1%) stddev-sans-first:0.73 12:10:05 INFO - PROCESS | 1917 | Values: 66.0 66.0 66.0 66.0 66.0 65.0 65.0 66.0 64.0 65.0 12:10:05 INFO - PROCESS | 1917 | -------- Summary: end -------- 12:10:05 INFO - PROCESS | 1917 | 12:10:06 INFO - TEST-INFO | 1917: exit 0 12:10:06 INFO - TEST-OK | kraken | took 59113ms 12:10:06 INFO - SUITE-END | took 1176s 12:10:06 INFO - Completed test suite (00:19:37) 12:10:06 INFO - javascript benchmark 12:10:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3399.3201359728055, 3407.642197569255, 3419.4870769384606, 3439.363717712222, 3496.230829217573, 5692.288463942007, 5710.114932185518, 5730.111832665933, 5742.799002034924, 5757.021306377916, 5658.886822263552, 5737.971310143444, 5744.454276843703, 5749.281339832521, 5781.913271300934, 5220.164773636219, 5242.659227150242, 5276.0, 5287.233351164098, 5334.919976200341, 5230.92153617696, 5231.293775340338, 5243.2659427680155, 5321.36143662761, 5351.812686555972, 5052.8484145475695, 5070.264811602316, 5117.667351622133, 5343.412224655285, 5348.197770334442, 5283.260343551887, 5305.230741542455, 5306.8407947761625, 5308.416074231832, 5344.812931547377, 5177.948220517785, 5303.522682958553, 5312.734363281859, 5329.040772660919, 5343.278657381243, 5600.327960644708, 5627.662340259557, 5659.122835960433, 5774.422557744234, 5779.393163717791, 6124.480006369302, 6129.7981007102635, 6136.877262454771, 6194.4115309045565, 6215.56491045627, 6225.8132256032395, 6265.342139075377, 6266.968665156645, 6273.215848018997, 6275.341089185616, 5648.293963254593, 5727.656340619493, 5804.2744656917885, 5824.440551087098, 5846.1523079153285, 6202.81391558254, 6245.18812554365, 6247.437730604177, 6257.0, 6264.1856558648, 6112.480439162721, 6138.14066030756, 6162.476189523941, 6165.10605962133, 6173.506119510428, 6128.78549250783, 6147.493864003348, 6264.718087686065, 6274.309825919146, 6284.088807122942, 6095.238095238095, 6137.297691397268, 6148.616561273678, 6148.770245950827, 6154.984427569401, 6146.61701117254, 6206.286277078194, 6218.253809542884, 6287.308396076428, 6304.9281622123435, 4934.259861020875, 4985.775640096204, 4986.850394488171, 5001.924971125436, 5022.723750193702, 4400.625946794495, 4486.12520558488, 4505.121501307213, 4507.774611269423, 4508.256137737302, 5621.353544342453, 5629.7185140742795, 5653.717314134276, 5667.688277144714, 5707.3721890592005, 6266.248050234001, 6277.089821975788, 6281.937180628227, 6291.056341548804, 6296.968515157395, 5605.243292155588, 5716.657000579979, 5730.7421166047625, 5748.281464816898, 5766.740496677659, 5268.025415298182, 5317.973410132925, 5339.332583427072, 5415.83752487426, 5420.91868621971, 6173.444390004831, 6185.597936134137, 6219.595726277868, 6273.153124328157, 6285.874282514233, 5128.128218202989, 6174.413430724074, 6276.717547710456, 6295.244570651551, 6299.0, 6161.399937128673, 6171.59884607499, 6214.036824292242, 6217.844553886189, 6262.46769024638, 5165.741712914414, 5174.223866420067, 6091.238595175603, 6129.387061293835, 6134.141220229082, 6254.843628909131, 6259.843503912439, 6263.530235232284, 6269.96865015672, 6292.8426789328805, 4661.277501987197, 6084.117802918464, 6138.355472675484, 6156.353582873734, 6157.199564056644, 4989.700617962933, 5946.494547963472, 6033.939660603338, 6062.605930614496, 6072.392760723892, 5962.373950735284, 5969.164316995537, 5970.223870896755, 5972.731227094878, 5979.910301345571, 6104.298005729398, 6109.816705498843, 6117.632942023492, 6131.264248290234, 6135.969320153371, 5766.365699772938, 5810.215620891295, 5823.592348535732, 5862.237909071964, 5959.0], "value": 5679.809489321132, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [463.9907201855963, 464.6538328944936, 490.5903570518617, 516.4835164835165, 555.4473299067429, 30825.22936926578, 40123.39814902775, 41527.792361038155, 41760.95597610057, 43374.78312608432, 42109.0, 42455.78772106143, 42845.57154428455, 43004.924876878096, 43091.56908430922, 8812.38313318068, 8993.190612844843, 9419.387739796926, 9582.712518624452, 9593.47235902025, 10059.849102263435, 11292.322460652345, 11569.595064172756, 11602.825957610643, 11825.940870295679, 11574.594889178881, 11585.42072896356, 11653.883461165407, 11663.183577149603, 11663.475143618514, 11616.419179041015, 11667.766644667145, 11669.533218671286, 11679.124065695021, 11684.70788230301, 11408.486618102123, 11500.942495287554, 11515.481803318871, 11533.308001519852, 11533.653990380219, 40381.192376152314, 40529.79735101335, 40576.797116014524, 40662.0, 40682.79658601688, 3203.2312245061016, 3315.784474009182, 3430.519727238189, 3720.9441858372147, 3951.8616848410456, 28475.010123936896, 29541.818327266883, 29602.555961660593, 30653.69346306553, 31354.05937821869, 3257.9185520361943, 3284.5894263217097, 3314.7182489488423, 3406.625271220164, 3411.300683359905, 495841.0, 500137.0, 500267.0, 500659.0, 500949.0, 34765.0, 57321.0, 57486.42513574894, 57560.424395756345, 57591.712041439525, 34597.65402345944, 36702.0, 36749.26501469956, 36755.081122971606, 36755.89732308035, 14735.92632036833, 14937.850621493862, 14940.850591494163, 14959.326830292663, 14961.850381496046, 11306.321620702784, 11493.252938558968, 12293.0780191486, 12418.56535021288, 12499.50001999928, 7991.360691144694, 8012.559309237931, 8022.839543209103, 8079.151689072681, 8100.513969161869, 3256.413845507784, 3270.7546933980047, 3282.0646115856866, 3300.5214243934497, 3302.752293577991, 896.0, 975.6292608808608, 992.270681049428, 1021.6066814276558, 1041.239894876729, 30187.396252074836, 30307.93922212712, 30843.0, 30958.916437925014, 30991.845040774653, 990.7869807991317, 1035.177034257767, 1078.347599702169, 1084.8535447714457, 1137.4767606900919, 15026.0, 15582.532524024298, 15611.0, 15769.842301577068, 15923.964942278715, 599309.0, 611431.0, 611521.0, 611804.0, 613020.0, 47159.764201178776, 48545.5145448541, 48714.78213044702, 48856.511434885906, 48876.7556162224, 1229.7724920889664, 1259.924404535731, 1327.794191900257, 1339.1028011232497, 1383.9377228024764, 29768.0, 31123.377532448772, 31948.68051319457, 32430.0, 32675.509867352484, 58115.70942145262, 58696.0, 58716.412835872805, 58927.0, 59079.70460147672, 508255.0, 512440.0, 512525.0, 513422.0, 513857.0, 24304.878475607507, 24463.877680611484, 24469.388265292797, 26554.203373898814, 27558.448831022866, 38397.0, 43761.78119109384, 46448.53551464442, 47236.7638161807, 47703.52296476991, 32632.34735305328, 33955.32089358248, 35909.820450898624, 37841.0, 39204.80397598108, 38705.806470967465, 38980.025499362746, 39039.80480097581, 39188.6081139185, 39330.230139643216, 32902.506462402605, 33334.83332583419, 38827.80586097051, 39841.0, 39894.2021159581, 33942.490862637576, 34514.482282765275, 35303.0, 35367.646323536435, 35395.0, 25678.358041049123, 25871.094511692, 25985.350366240997, 26123.801586073663, 26382.0], "value": 18889.423910000834, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.64233806320146, 332.3187465695325, 354.4506015675702, 387.7421514692729, 409.39614069247864, 19500.122494487747, 20221.090050947707, 20648.587028259426, 21284.148634054658, 21500.354989350304, 19881.0, 19966.0, 20330.881801500913, 20374.796252037475, 20547.972601369947, 4721.3390125382475, 5778.768849246025, 5949.048152295633, 6034.8793024139495, 6038.094285857134, 4288.506821715496, 4509.729416235036, 4513.232750432434, 5874.853128671796, 5968.253968253968, 4408.669349798762, 4522.841700540482, 4536.478304994918, 4544.977275113636, 4606.97696511517, 4516.2548179550495, 6048.939510604881, 6391.936080639227, 6640.103586015898, 6646.069550262967, 5562.86092847678, 5748.683822389767, 5791.420857914217, 5796.623219490762, 5817.680027598481, 25267.20057161557, 25351.0, 25399.746002539923, 25709.35726606831, 25796.742032579623, 2220.611393006234, 2335.9649605255763, 2339.3449834046323, 2401.0, 2601.2846467221475, 15016.624584385369, 15544.76682849758, 15716.842831571652, 15983.920080399523, 16400.343986240536, 1888.9149988250563, 1891.9688769620452, 1902.9238830446766, 1912.1490936533248, 1950.3368854589507, 104716.0, 113067.86932130739, 115319.0, 130214.99999999905, 132861.0, 11271.492782824793, 11549.307041577533, 11592.072634189244, 11720.179587428798, 11898.821517677241, 14739.778903316459, 14795.0, 14803.407863685547, 14813.185274809774, 14817.62955926089, 8314.251717345467, 8586.656533738706, 8588.957055214683, 8678.0, 8720.12798720123, 8409.528332541902, 8417.873731894026, 8422.915770842214, 8568.0, 8596.570171491401, 4533.478649955231, 4617.861464156081, 4634.980304333041, 4678.941265843018, 4704.482506924235, 1760.2958816473513, 1859.3492277702696, 1926.6532024235491, 1934.7291379206922, 1972.5364539333245, 831.2975535672347, 851.3870013590205, 871.2463718883247, 948.393028461785, 1001.6594357918343, 20212.797872021092, 21751.67372489414, 21752.782472175393, 21859.344219673436, 21976.45058873541, 911.2527727263713, 933.143045339769, 947.5262368815593, 948.374073111743, 984.2175470500969, 10765.0, 11206.271592346471, 11260.268082574607, 11385.601503947322, 11389.3166410014, 597018.0, 603604.0, 606453.0, 627407.0, 630711.8464407648, 129358.0, 129710.0, 130233.0, 134898.0, 136274.3186284062, 921.2952091649893, 957.6265256549951, 965.2712202287369, 967.1972263021676, 970.6166064404662, 17926.5518362042, 18839.058047097864, 19179.0, 19230.230790768772, 19238.326658566883, 51593.48406515887, 52204.47795521996, 55203.72398137984, 55361.0, 57092.0, 63389.0, 75258.24741752513, 77693.0, 78639.21360786319, 78923.21076789159, 7906.248906353887, 8110.391720621095, 8326.084130745734, 8385.874211886705, 8526.317894568543, 12381.75236495283, 12848.229106253655, 13199.538016169388, 13246.867531324564, 13540.322983850965, 10239.436830974368, 11099.944500277446, 11306.03900658072, 11416.257943233662, 11421.486033128363, 9756.951215243878, 11091.44542772842, 11288.548458061914, 11328.35561729454, 11526.538938442704, 11477.827832582685, 11485.425728713364, 11556.479958401724, 11778.882211177779, 11847.407629618312, 8129.227723366271, 8244.54654993957, 8557.101504341954, 8572.228499435081, 8625.741227763177, 10970.890291097307, 11056.170787191153, 11421.771564568497, 11511.597094101666, 11539.249948753304], "value": 9661.424759533827, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.5287149497683, 1485.2796393749034, 1509.924503774811, 1668.9165541722919, 1820.2809890093406, 7607.391408687306, 8027.678892844287, 8029.317508011826, 8045.436819422643, 8048.758537243892, 8169.428140030201, 8445.197706217914, 8448.704295349664, 8539.743807685763, 8568.614412351444, 2088.227355878327, 2375.406148462884, 2399.8080153587757, 2403.9639405408934, 2404.9639255411184, 2364.420716924356, 2394.7485514021037, 2417.55275274074, 2420.2739178246457, 2423.103451722865, 2261.7851304126084, 2273.6589511573316, 2285.748567657556, 2295.5638428698576, 2296.9310920672406, 2334.7781960713705, 2335.6262997920335, 2366.6450032495177, 2372.8932198050957, 2378.452955820171, 1947.51312171957, 2340.8010319122895, 2385.1651921827397, 2401.11158871217, 2404.8576925960206, 8481.151884811532, 8556.871646925301, 8557.0, 8567.443116197428, 8569.871451928164, 5039.949600503985, 5058.671186372874, 5209.400918894337, 5211.348581427322, 5242.135047717122, 3357.345317663057, 3468.809215493147, 3589.4974703541525, 3592.8742494012586, 3605.441156620728, 1060.7719340341787, 1082.5561519776932, 1091.4488183467377, 1113.2263077161376, 1115.7656892052678, 10919.836202456969, 11049.392283424408, 11165.497552610152, 11166.0, 11171.776564468664, 4613.700109492872, 4651.720896746206, 4751.144793937125, 4769.332293478916, 4770.594499467515, 8566.871496927552, 9586.233101351874, 9590.568424420917, 9591.856122158173, 9596.040395960348, 5265.131253343156, 5265.947340526623, 5271.578273738169, 5273.34083239595, 5277.155655095166, 4242.854429304132, 4308.289132293136, 4334.349847522897, 4669.673122881366, 4741.099191153669, 3840.327942610032, 3844.692424606025, 3931.567527571965, 3978.6021397860563, 3996.980015099906, 1251.1179618369029, 1273.7452509498137, 1275.5471807508386, 1288.8260084888607, 1290.103378152194, 829.4608504472142, 897.3718397122041, 900.122380678846, 902.4359775140537, 911.093462005309, 5513.338399392019, 5744.224529688522, 5769.596128271065, 5782.479576838105, 5859.94140058594, 910.2444970674325, 911.813078318943, 914.5290175559592, 917.559571405729, 957.4159762544842, 3706.4625629283605, 3723.7765734056043, 3753.793541355252, 3794.4118661607495, 3840.539135303781, 9944.850827237597, 10239.334443261165, 10323.380597164194, 10324.328918620266, 10336.638217662347, 10278.280520363503, 10284.434356110485, 10299.845502317472, 10312.484375781181, 10320.0, 7549.0941087071005, 7862.724804631925, 8055.234752698484, 8060.637271322805, 8079.990001249844, 5525.557955363481, 5623.831285061455, 5849.766009359748, 5858.326292476419, 5873.2658417697785, 7712.383009359126, 9298.442093474414, 9492.382995105296, 9516.095970882756, 9638.180754635934, 8316.209960053786, 9593.952030239805, 9724.416535007922, 9785.755356116155, 9799.608015679292, 6682.198136223684, 6867.759628412981, 7081.752138675121, 7327.047483827068, 7673.19431459711, 7993.320567751806, 8102.230288122619, 8212.712555060543, 8213.630386632496, 8222.506649601042, 6202.72087756043, 7164.605946672983, 7199.892001620085, 7238.710451581877, 7266.781996540112, 7034.718611255493, 7105.50261481712, 7128.6792094356915, 7186.748463803742, 7308.976743255842, 5821.592488525763, 6630.30381809903, 6713.0, 6794.83012924661, 6799.694013769491, 4672.229082201398, 4760.880977975578, 4870.439899411613, 4915.705057696549, 4959.677620954626, 4838.588719958702, 4863.2461968394955, 4992.850214493571, 4999.600031997505, 5001.349824522788], "value": 4460.164702664022, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.8418653926881, 300.9307859192386, 306.6917747663598, 307.96458407283154, 308.6866830167381, 4227.660148482699, 4422.977885110578, 5243.449437809028, 5313.681179129255, 5373.838784836456, 4500.0, 5007.198848184291, 5121.795128194877, 5153.201253805657, 5274.441895680592, 3373.8650453981813, 3422.469517224828, 3996.582067848953, 4064.654504367132, 4098.8360465581345, 4043.1913617276514, 4056.8377264909514, 4066.031796788346, 4087.3460246360587, 4091.3021096245025, 3522.559680039995, 3625.6918161956264, 3650.6349365063547, 4014.7390419622775, 4028.8791336259815, 3445.500402441632, 3654.9086272843124, 3694.9815250923843, 4069.0, 4078.347464405681, 2958.881644734208, 3273.461473107636, 3519.243362677011, 3529.4705794130828, 3530.541029666127, 5124.538791508782, 5151.562117220041, 5171.922421163686, 5173.275741396207, 5190.351206099238, 4049.6760259179196, 4571.58855702985, 4614.13923367511, 4618.145643056046, 4624.237000894848, 5170.508801663836, 5505.421930697299, 5524.58565607581, 5527.281453411071, 5535.25274087997, 3877.9030524236837, 3879.9612003879884, 3892.6496615304477, 3895.454636350885, 3895.7272990890647, 5342.385625653022, 5593.440655934414, 5775.249217601685, 5780.942190578083, 5828.2131912191735, 3465.4455287153933, 3622.836972336251, 3787.2046870157023, 3821.904452388657, 3823.923521529554, 3895.24042811649, 3898.142408670088, 3899.2981263372867, 3902.70729695274, 3927.8821635350414, 3780.8865734028022, 4211.599898009684, 4491.393661855608, 4564.109998550317, 4564.748938808398, 5239.790408383698, 5514.641548299428, 5553.583481238923, 5562.608078526273, 5575.191597218381, 1152.0035169578255, 1179.097990037622, 1189.822076144628, 1247.2516490105863, 1279.5393658283197, 776.9611519424006, 818.5675068629897, 832.4963397144761, 843.4138273899581, 844.2359664503634, 4379.759113248802, 4401.261501706808, 4590.862274131781, 4790.185668436374, 4845.964694828181, 5732.627379220337, 5747.798827041033, 5758.992176369119, 5762.971185144047, 5791.739371728282, 4985.252212168131, 5144.408393034849, 5200.739963001834, 5230.843074707765, 5236.0575096483, 2499.6500489931423, 2740.7533322001113, 2839.716028397144, 2841.545352743551, 2846.8291902485503, 4787.976060119677, 5578.0, 5632.9436705632415, 5639.520640745583, 5670.603057785998, 4611.403105577588, 4843.515648435128, 5166.715830629276, 5532.197831314437, 5543.2793736814765, 5212.270282160424, 5669.659820410789, 5683.914741278884, 5687.658740475585, 5706.9429305707245, 4775.3763720335255, 4776.355192049168, 5195.454477279831, 5261.105612046038, 5445.918311225414, 4735.502772209006, 4762.9521505268785, 5535.367066715248, 5694.743736531949, 5706.343770466284, 4537.500874903824, 5116.769745361393, 5748.597598168088, 5931.301257927719, 6037.849053773691, 3103.90688279352, 3286.211309285802, 3846.4230365445405, 3863.7295389322476, 3871.9352178151235, 5188.4953363525665, 5350.582095744709, 5710.457506536873, 5744.310682718101, 5801.767929282782, 4638.188317044436, 4925.596205081534, 5066.645334826527, 5613.101903695389, 5640.4077571856005, 5245.750941737205, 5325.387580428145, 5524.723763811713, 5642.60501764889, 5656.943430565806, 4997.375328083989, 5234.0, 5462.644928079662, 5507.402853172535, 5516.641418307797, 4768.070226305837, 4949.604031677529, 5203.92194117081, 5331.573474122139, 5488.490665067138, 5413.269208656939, 5442.550852116484, 5480.91778623313, 5511.3937466879415, 5525.723713814213], "value": 3979.707015704783, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.3569088148327, 768.9423293253008, 799.0730752327302, 808.6320724070547, 815.9714409995652, 13932.930335348321, 15305.770413443808, 15573.45492907747, 15573.766393504093, 15605.14171720555, 12720.173188742725, 13810.72378552431, 13833.239171845544, 13995.650108747286, 14021.228832414214, 817.8282560662268, 818.758466252454, 819.045811629451, 822.2599660305713, 832.8709050097244, 684.9794506164823, 706.7385067525023, 816.4611356504709, 832.309183377798, 837.6398148796015, 887.2325438495719, 890.9910900890973, 891.180114294847, 891.3537685178259, 892.7411050795295, 887.786931136529, 887.8224355129, 888.6178943054484, 888.7955770172864, 889.5507768576892, 655.8458762190882, 655.9639219842907, 656.0421784195081, 656.4157899469476, 657.6580178307302, 13869.514566990107, 13872.653183670389, 13881.722365552734, 13896.513622023282, 14014.92992535041, 13319.934405247654, 13633.522826701117, 13712.0, 13786.448542058306, 13924.791128133085, 11431.705432154198, 11486.770264594661, 11680.474378652982, 11742.530298788039, 11785.0, 3683.631636836322, 3687.9631203687886, 3717.9442308365396, 3751.2497500499735, 3853.9229215415817, 95066.04933950641, 100053.0, 100247.99504009879, 100294.0, 100551.49724251404, 10199.235057370726, 10275.280730348804, 10723.678289651323, 10750.94624526888, 10882.455877206108, 20389.0, 20551.794482055288, 20564.0, 20585.89707051455, 20656.89671551663, 7655.272749088827, 7690.038745156856, 7909.367250620052, 7977.800554986055, 8021.2379823916635, 4320.697551171388, 4373.518912919576, 4450.532694067077, 4479.350494178326, 4546.976930190681, 3375.8649654013566, 3500.4049311617086, 3501.4222653261927, 3504.5794504659602, 3507.14075051614, 627.2034516164537, 639.7824739588563, 650.1061041068531, 659.1859054068221, 662.9138212032404, 567.5261156933924, 640.9262934762469, 653.6372313366128, 672.5225090185925, 672.8755180291662, 8815.382923195315, 9328.720138395724, 9407.811843763224, 9512.524373781283, 9516.666916657883, 563.4250679438953, 623.7660877171061, 645.9761278373736, 682.3551743602249, 693.4279219643814, 4050.1697152083752, 4346.608805207483, 4457.242268814244, 4534.523874993144, 4551.795169217393, 74972.0, 84949.20406367476, 125871.0, 126999.0, 130376.34811826069, 51444.0, 70198.0, 75535.24464755392, 97143.0, 98598.50700746595, 84867.15132848716, 88370.23259534902, 88950.0, 92484.0, 95722.0, 8803.339749518684, 8818.0, 8868.068852770366, 8940.496660934949, 8959.328050396376, 50073.74963125307, 51899.962000760526, 59532.0, 60583.78832423239, 62682.68658656678, 63972.28291029375, 70802.93795592966, 74907.62546187235, 75197.12007199864, 76860.2313976853, 12265.816012759637, 12359.69100772488, 12603.306818124724, 12730.427130778951, 13210.94312454982, 14145.858541414866, 14402.351894164998, 14407.0, 14501.78247326312, 14662.26688665541, 12808.935955320163, 12843.871561284268, 12999.1550549214, 13475.528356507475, 13509.121907076009, 12861.2926289055, 13434.462621495031, 13954.162750235018, 14004.789928150882, 14085.788713169106, 12424.316662583644, 13239.57611171658, 13535.390907408993, 13689.45242190341, 13965.511207107702, 11013.779724405307, 11262.479565258585, 11345.659630211107, 11543.4805433754, 11555.306681598795, 9366.614196836983, 11277.880763020938, 11322.547098116313, 11372.26379188364, 11500.82748758786], "value": 7394.338816991131, "unit": "score"}], "name": "dromaeo_css", "value": 7171.7236757149985, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 116.0, 115.0, 115.0, 115.0, 115.0, 113.0, 115.0, 116.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 109.0, 107.0, 146.0, 108.0, 107.0, 131.0, 134.0, 169.0, 106.0], "value": 126.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 178.0, 186.0, 184.0, 183.0, 183.0, 183.0, 184.0, 182.0, 181.0], "value": 183.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 59.0, 102.0, 59.0, 62.0, 58.0, 59.0, 80.0, 58.0], "value": 67.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 69.0, 93.0, 69.0, 69.0, 67.0, 89.0, 67.0, 68.0, 92.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 90.0, 88.0, 90.0, 85.0, 90.0, 84.0, 90.0, 86.0], "value": 88.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 103.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 133.0, 124.0, 83.0, 84.0, 84.0, 83.0, 84.0, 81.0, 83.0], "value": 93.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 52.0, 53.0, 54.0, 56.0, 56.0, 57.0, 56.0, 56.0, 57.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 71.0, 79.0, 73.0, 71.0, 72.0, 68.0, 67.0, 67.0, 68.0], "value": 69.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 81.0, 80.0, 83.0, 69.0, 89.0, 79.0, 76.0, 99.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 134.0, 136.0, 145.0, 143.0, 154.0, 141.0, 151.0, 195.0, 166.0], "value": 150.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 180.0, 210.0, 204.0, 161.0, 164.0, 161.0], "value": 172.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 65.0, 66.0, 64.0, 65.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1440.6, "alertThreshold": 2.0}]} 12:10:06 INFO - Return code: 0 12:10:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:10:06 INFO - # TBPL SUCCESS # 12:10:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:10:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:10:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:10:06 INFO - 2017-02-14 12:10:06.609 screenresolution[1921:18770] starting screenresolution argv=screenresolution get 12:10:06 INFO - 2017-02-14 12:10:06.613 screenresolution[1921:18770] Display 0: 1600x1200x32@60 12:10:06 INFO - 2017-02-14 12:10:06.619 screenresolution[1922:18773] starting screenresolution argv=screenresolution list 12:10:06 INFO - Available Modes on Display 0 12:10:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:10:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:10:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:10:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:10:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:10:06 INFO - Intel Iris: 12:10:06 INFO - Chipset Model: Intel Iris 12:10:06 INFO - Type: GPU 12:10:06 INFO - Bus: Built-In 12:10:06 INFO - VRAM (Dynamic, Max): 1536 MB 12:10:06 INFO - Vendor: Intel (0x8086) 12:10:06 INFO - Device ID: 0x0a2e 12:10:06 INFO - Revision ID: 0x0009 12:10:06 INFO - Displays: 12:10:06 INFO - Display: 12:10:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:10:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:10:06 INFO - Display Serial Number: 1600x1200 60 12:10:06 INFO - Main Display: Yes 12:10:06 INFO - Mirror: Off 12:10:06 INFO - Online: Yes 12:10:06 INFO - Rotation: Supported 12:10:06 INFO - Return code: 0 12:10:06 INFO - Running post-action listener: _resource_record_post_action 12:10:06 INFO - [mozharness: 2017-02-14 20:10:06.864734Z] Finished run-tests step (success) 12:10:06 INFO - Running post-run listener: _resource_record_post_run 12:10:06 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 958464; Write bytes: 495505920; Read time: 13; Write time: 1567 12:10:06 INFO - TinderboxPrint: CPU usage
53.3% 12:10:06 INFO - TinderboxPrint: I/O read bytes / time
958,464 / 13 12:10:06 INFO - TinderboxPrint: I/O write bytes / time
495,505,920 / 1,567 12:10:06 INFO - TinderboxPrint: CPU idle
2,242.2 (46.7%) 12:10:06 INFO - TinderboxPrint: CPU system
953.7 (19.9%) 12:10:06 INFO - TinderboxPrint: CPU user
1,601.8 (33.4%) 12:10:06 INFO - TinderboxPrint: Swap in / out
193,232,896 / 0 12:10:06 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 188705280; Write bytes: 189101568; Read time: 17840; Write time: 405 12:10:06 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 913408; Write bytes: 299219968; Read time: 12; Write time: 1133 12:10:07 INFO - Running post-run listener: _upload_blobber_files 12:10:07 INFO - Blob upload gear active. 12:10:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:10:07 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 12:10:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:10:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:10:07 INFO - (blobuploader) - INFO - Open directory for files ... 12:10:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:10:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:10:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:10:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:10:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:10:08 INFO - (blobuploader) - INFO - Done attempting. 12:10:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:10:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:10:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:10:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:10:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:10:09 INFO - (blobuploader) - INFO - Done attempting. 12:10:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:10:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:10:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:10:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:10:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:10:12 INFO - (blobuploader) - INFO - Done attempting. 12:10:12 INFO - (blobuploader) - INFO - Iteration through files over. 12:10:12 INFO - Return code: 0 12:10:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:10:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:10:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c200d7fd9d211823197b1bccef3d35fcbf90a910b1d6d62166ae6a318e8c777945063723d1f11ead86e91856797a3856f89406aa4bc852973534e1e469d7015f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/06b4be39e6a90ea35de052541ac3efc13f0894d43dca3f3c0eee80602ec8258e67409398e2d52332a7f5fa34fb4c769e7250840577c2fa1567e5cb875e3e1cff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/74f8d3140272d1b5678c3952849117bc40b83d1f3a5bc467633784bcd09f64e51be52ea74b07735eea16922a49a4cd6486db5f0b21d9d43329a961f2708b21a3"} 12:10:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:10:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:10:12 INFO - Contents: 12:10:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c200d7fd9d211823197b1bccef3d35fcbf90a910b1d6d62166ae6a318e8c777945063723d1f11ead86e91856797a3856f89406aa4bc852973534e1e469d7015f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/06b4be39e6a90ea35de052541ac3efc13f0894d43dca3f3c0eee80602ec8258e67409398e2d52332a7f5fa34fb4c769e7250840577c2fa1567e5cb875e3e1cff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/74f8d3140272d1b5678c3952849117bc40b83d1f3a5bc467633784bcd09f64e51be52ea74b07735eea16922a49a4cd6486db5f0b21d9d43329a961f2708b21a3"} 12:10:12 INFO - Running post-run listener: copy_logs_to_upload_dir 12:10:12 INFO - Copying logs to upload dir... 12:10:12 INFO - mkdir: /builds/slave/test/build/upload/logs 12:10:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.425117 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-02-14 12:10:12.700059) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-14 12:10:12.703960) ========= 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.j0KEffJXa5/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.dLHFzbA61L/Listeners TMPDIR=/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c200d7fd9d211823197b1bccef3d35fcbf90a910b1d6d62166ae6a318e8c777945063723d1f11ead86e91856797a3856f89406aa4bc852973534e1e469d7015f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/06b4be39e6a90ea35de052541ac3efc13f0894d43dca3f3c0eee80602ec8258e67409398e2d52332a7f5fa34fb4c769e7250840577c2fa1567e5cb875e3e1cff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/74f8d3140272d1b5678c3952849117bc40b83d1f3a5bc467633784bcd09f64e51be52ea74b07735eea16922a49a4cd6486db5f0b21d9d43329a961f2708b21a3"} build_url:https://queue.taskcluster.net/v1/task/QCtd5JFzRo2l0EA7BWXuAQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011180 build_url: 'https://queue.taskcluster.net/v1/task/QCtd5JFzRo2l0EA7BWXuAQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c200d7fd9d211823197b1bccef3d35fcbf90a910b1d6d62166ae6a318e8c777945063723d1f11ead86e91856797a3856f89406aa4bc852973534e1e469d7015f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/06b4be39e6a90ea35de052541ac3efc13f0894d43dca3f3c0eee80602ec8258e67409398e2d52332a7f5fa34fb4c769e7250840577c2fa1567e5cb875e3e1cff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/74f8d3140272d1b5678c3952849117bc40b83d1f3a5bc467633784bcd09f64e51be52ea74b07735eea16922a49a4cd6486db5f0b21d9d43329a961f2708b21a3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-14 12:10:12.739109) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 12:10:12.739396) ========= 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.j0KEffJXa5/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.dLHFzbA61L/Listeners TMPDIR=/var/folders/v0/xt40qp0j7dbbsm7xhv27_ww000000w/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.005100 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 12:10:12.788465) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-14 12:10:12.789124) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-14 12:10:12.789639) ========= ========= Total master_lag: 0.19 =========