builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0162 starttime: 1479149059.27 results: success (0) buildid: 20161114074144 builduid: c0ce765cf2c74afa85cbf7cb62a44e31 revision: 8cdff71808a0e11361bca7f218658c4343c730ca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 10:44:19.265878) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 10:44:19.266326) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 10:44:19.266604) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 10:44:19.290374) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 10:44:19.290825) ========= 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.VjQh7eVbzu/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.6X3MyeUUqa/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-14 10:44:19-- 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% 155M=0s 2016-11-14 10:44:19 (155 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124049 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 10:44:19.437172) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 10:44:19.437490) ========= 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.VjQh7eVbzu/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.6X3MyeUUqa/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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.019447 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 10:44:19.486228) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 10:44:19.486611) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8cdff71808a0e11361bca7f218658c4343c730ca --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8cdff71808a0e11361bca7f218658c4343c730ca --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VjQh7eVbzu/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.6X3MyeUUqa/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-14 10:44:19,566 truncating revision to first 12 chars 2016-11-14 10:44:19,566 Setting DEBUG logging. 2016-11-14 10:44:19,566 attempt 1/10 2016-11-14 10:44:19,566 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8cdff71808a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 10:44:20,654 unpacking tar archive at: mozilla-aurora-8cdff71808a0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.334385 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 10:44:20.844867) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 10:44:20.845223) ========= script_repo_revision: 8cdff71808a0e11361bca7f218658c4343c730ca ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 10:44:20.845615) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 10:44:20.845895) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 10:44:20.864290) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-11-14 10:44:20.864659) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VjQh7eVbzu/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.6X3MyeUUqa/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 10:44:21 INFO - MultiFileLogger online at 20161114 10:44:21 in /builds/slave/test 10:44:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:44:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:44:21 INFO - {'append_to_log': False, 10:44:21 INFO - 'base_work_dir': '/builds/slave/test', 10:44:21 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:44:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:44:21 INFO - 'branch': 'Mozilla-Aurora', 10:44:21 INFO - 'buildbot_json_path': 'buildprops.json', 10:44:21 INFO - 'config_files': ('talos/mac_config.py',), 10:44:21 INFO - 'default_actions': ('clobber', 10:44:21 INFO - 'read-buildbot-config', 10:44:21 INFO - 'download-and-extract', 10:44:21 INFO - 'populate-webroot', 10:44:21 INFO - 'create-virtualenv', 10:44:21 INFO - 'install', 10:44:21 INFO - 'run-tests'), 10:44:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:44:21 INFO - 'download_minidump_stackwalk': True, 10:44:21 INFO - 'download_symbols': 'ondemand', 10:44:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:44:21 INFO - 'tooltool.py': '/tools/tooltool.py', 10:44:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:44:21 INFO - '/tools/misc-python/virtualenv.py')}, 10:44:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:44:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:44:21 INFO - 'installer_path': 'installer.exe', 10:44:21 INFO - 'log_level': 'info', 10:44:21 INFO - 'log_name': 'talos', 10:44:21 INFO - 'log_to_console': True, 10:44:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:44:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:44:21 INFO - 'opt_config_files': (), 10:44:21 INFO - 'pip_index': False, 10:44:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:44:21 INFO - 'cmd': ('bash', 10:44:21 INFO - '-c', 10:44:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:44:21 INFO - 'enabled': True, 10:44:21 INFO - 'halt_on_failure': False, 10:44:21 INFO - 'name': 'check_screen_resolution'},), 10:44:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:44:21 INFO - 'cmd': ('bash', 10:44:21 INFO - '-c', 10:44:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:44:21 INFO - 'enabled': True, 10:44:21 INFO - 'halt_on_failure': False, 10:44:21 INFO - 'name': 'check_screen_resolution'},), 10:44:21 INFO - 'run_cmd_checks_enabled': True, 10:44:21 INFO - 'sps_profile': False, 10:44:21 INFO - 'sps_profile_interval': 0, 10:44:21 INFO - 'suite': 'dromaeojs-e10s', 10:44:21 INFO - 'system_bits': '32', 10:44:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:44:21 INFO - 'title': 't-yosemite-r7-0162', 10:44:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:44:21 INFO - 'use_talos_json': True, 10:44:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:44:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:44:21 INFO - 'work_dir': 'build'} 10:44:21 INFO - [mozharness: 2016-11-14 18:44:21.069664Z] Running clobber step. 10:44:21 INFO - Running pre-action listener: _resource_record_pre_action 10:44:21 INFO - Running main action method: clobber 10:44:21 INFO - rmtree: /builds/slave/test/build 10:44:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:44:23 INFO - Running post-action listener: _resource_record_post_action 10:44:23 INFO - [mozharness: 2016-11-14 18:44:23.108700Z] Finished clobber step (success) 10:44:23 INFO - [mozharness: 2016-11-14 18:44:23.108906Z] Running read-buildbot-config step. 10:44:23 INFO - Running pre-action listener: _resource_record_pre_action 10:44:23 INFO - Running main action method: read_buildbot_config 10:44:23 INFO - Using buildbot properties: 10:44:23 INFO - { 10:44:23 INFO - "project": "", 10:44:23 INFO - "product": "firefox", 10:44:23 INFO - "script_repo_revision": "production", 10:44:23 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 10:44:23 INFO - "repository": "", 10:44:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 10:44:23 INFO - "buildid": "20161114074144", 10:44:23 INFO - "pgo_build": "False", 10:44:23 INFO - "basedir": "/builds/slave/test", 10:44:23 INFO - "buildnumber": 27, 10:44:23 INFO - "slavename": "t-yosemite-r7-0162", 10:44:23 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 10:44:23 INFO - "platform": "yosemite_r7", 10:44:23 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 10:44:23 INFO - "branch": "mozilla-aurora", 10:44:23 INFO - "repo_path": "releases/mozilla-aurora", 10:44:23 INFO - "revision": "8cdff71808a0e11361bca7f218658c4343c730ca", 10:44:23 INFO - "stage_platform": "macosx64", 10:44:23 INFO - "builduid": "c0ce765cf2c74afa85cbf7cb62a44e31", 10:44:23 INFO - "slavebuilddir": "test" 10:44:23 INFO - } 10:44:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 10:44:23 INFO - Running post-action listener: _resource_record_post_action 10:44:23 INFO - [mozharness: 2016-11-14 18:44:23.114710Z] Finished read-buildbot-config step (success) 10:44:23 INFO - [mozharness: 2016-11-14 18:44:23.114932Z] Running download-and-extract step. 10:44:23 INFO - Running pre-action listener: _resource_record_pre_action 10:44:23 INFO - Running main action method: download_and_extract 10:44:23 INFO - mkdir: /builds/slave/test/build/tests 10:44:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:44:23 INFO - trying https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 10:44:23 INFO - Downloading https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 10:44:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 10:44:24 INFO - Downloaded 1199 bytes. 10:44:24 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 10:44:24 INFO - Using the following test package requirements: 10:44:24 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 10:44:24 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:44:24 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 10:44:24 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:44:24 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 10:44:24 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:44:24 INFO - u'jsshell-mac.zip'], 10:44:24 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:44:24 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 10:44:24 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 10:44:24 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:44:24 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 10:44:24 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:44:24 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 10:44:24 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:44:24 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 10:44:24 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:44:24 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 10:44:24 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 10:44:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 10:44:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:44:24 INFO - Fetch https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 10:44:24 INFO - Http code: 200 10:44:24 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 10:44:24 INFO - x-amz-cf-id: BrwM7er24NWjI8YezDpW2epRaN-jsH1r-BIzUdi5Uir3ibdCZiQV-Q== 10:44:24 INFO - x-amz-version-id: qEZpoxVrb8K_lOtz8d1xXpN4NyRiiL2Q 10:44:25 INFO - Expected file size: 16327509 10:44:25 INFO - Obtained file size: 16327509 10:44:31 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 10:44:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 10:44:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:44:31 INFO - Fetch https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 10:44:32 INFO - Http code: 200 10:44:32 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 10:44:32 INFO - x-amz-cf-id: TBfAziN2VI_nQSn1YvRPW4wWRvo7uvdo1DgihqjmpbR70X7xQHin7A== 10:44:32 INFO - x-amz-version-id: qEZpoxVrb8K_lOtz8d1xXpN4NyRiiL2Q 10:44:32 INFO - Expected file size: 16327509 10:44:32 INFO - Obtained file size: 16327509 10:44:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 10:44:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 10:44:39 INFO - Fetch https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 10:44:40 INFO - Http code: 200 10:44:40 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 10:44:40 INFO - x-amz-cf-id: y7uGnmKsOgdpvQSp-ZvdyuIRRNowLMswD-aLzs8XM5kV2aNcynnlDQ== 10:44:40 INFO - x-amz-version-id: jXsupoNyJ.YzlDUqzWygU8BmOV_JFB8G 10:44:40 INFO - Expected file size: 14409038 10:44:40 INFO - Obtained file size: 14409038 10:44:40 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')]} 10:44:40 INFO - trying https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:44:40 INFO - Downloading https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 10:44:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 10:44:43 INFO - Downloaded 114362341 bytes. 10:44:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:44:43 INFO - mkdir: /builds/slave/test/properties 10:44:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:44:43 INFO - Writing to file /builds/slave/test/properties/build_url 10:44:43 INFO - Contents: 10:44:43 INFO - build_url:https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:44:44 INFO - Running post-action listener: _resource_record_post_action 10:44:44 INFO - Running post-action listener: set_extra_try_arguments 10:44:44 INFO - [mozharness: 2016-11-14 18:44:44.248017Z] Finished download-and-extract step (success) 10:44:44 INFO - [mozharness: 2016-11-14 18:44:44.248160Z] Running populate-webroot step. 10:44:44 INFO - Running pre-action listener: _resource_record_pre_action 10:44:44 INFO - Running main action method: populate_webroot 10:44:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:44:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:44:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:44:44 INFO - '--tppagecycles', 10:44:44 INFO - '7'], 10:44:44 INFO - 'tests': ['tsvgm']}}, 10:44:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:44:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:44:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:44:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:44:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:44:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:44:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:44 INFO - 'talos_options': ['--disable-e10s'], 10:44:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:44:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:44:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:44 INFO - 'talos_options': ['--disable-e10s'], 10:44:44 INFO - 'tests': ['damp', 'tps']}, 10:44:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:44 INFO - 'tests': ['damp', 'tps']}, 10:44:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:44:44 INFO - 'tests': ['dromaeo_dom']}, 10:44:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:44:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:44:44 INFO - 'tests': ['basic_compositor_video']}, 10:44:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:44:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:44:44 INFO - 'tests': ['a11yr', 10:44:44 INFO - 'ts_paint', 10:44:44 INFO - 'tpaint', 10:44:44 INFO - 'sessionrestore', 10:44:44 INFO - 'sessionrestore_no_auto_restore', 10:44:44 INFO - 'tabpaint']}, 10:44:44 INFO - 'other-e10s': {'tests': ['a11yr', 10:44:44 INFO - 'ts_paint', 10:44:44 INFO - 'tpaint', 10:44:44 INFO - 'sessionrestore', 10:44:44 INFO - 'sessionrestore_no_auto_restore', 10:44:44 INFO - 'tabpaint']}, 10:44:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:44:44 INFO - 'ts_paint', 10:44:44 INFO - 'tpaint', 10:44:44 INFO - 'sessionrestore', 10:44:44 INFO - 'sessionrestore_no_auto_restore', 10:44:44 INFO - 'tabpaint']}, 10:44:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:44:44 INFO - 'ts_paint', 10:44:44 INFO - 'tpaint', 10:44:44 INFO - 'sessionrestore', 10:44:44 INFO - 'sessionrestore_no_auto_restore', 10:44:44 INFO - 'tabpaint']}, 10:44:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:44:44 INFO - 'tests': ['a11yr', 10:44:44 INFO - 'ts_paint', 10:44:44 INFO - 'tpaint', 10:44:44 INFO - 'sessionrestore', 10:44:44 INFO - 'sessionrestore_no_auto_restore', 10:44:44 INFO - 'tabpaint']}, 10:44:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:44:44 INFO - 'tests': ['a11yr', 10:44:44 INFO - 'ts_paint', 10:44:44 INFO - 'tpaint', 10:44:44 INFO - 'sessionrestore', 10:44:44 INFO - 'sessionrestore_no_auto_restore', 10:44:44 INFO - 'tabpaint']}, 10:44:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:44:44 INFO - 'tests': ['tsvgx', 10:44:44 INFO - 'tsvgr_opacity', 10:44:44 INFO - 'tart', 10:44:44 INFO - 'tscrollx', 10:44:44 INFO - 'cart']}, 10:44:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:44:44 INFO - 'tsvgr_opacity', 10:44:44 INFO - 'tart', 10:44:44 INFO - 'tscrollx', 10:44:44 INFO - 'cart']}, 10:44:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:44 INFO - 'talos_options': ['--disable-e10s'], 10:44:44 INFO - 'tests': ['tp5o']}, 10:44:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:44 INFO - 'tests': ['tp5o']}, 10:44:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:44 INFO - 'talos_options': ['--disable-e10s', 10:44:44 INFO - '--xperf_path', 10:44:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:44:44 INFO - 'tests': ['tp5n']}, 10:44:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:44 INFO - 'talos_options': ['--xperf_path', 10:44:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:44:44 INFO - 'tests': ['tp5n']}}, 10:44:44 INFO - 'talos.zip': {'path': '', 10:44:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:44:44 INFO - Running post-action listener: _resource_record_post_action 10:44:44 INFO - [mozharness: 2016-11-14 18:44:44.266305Z] Finished populate-webroot step (success) 10:44:44 INFO - [mozharness: 2016-11-14 18:44:44.266413Z] Running create-virtualenv step. 10:44:44 INFO - Running pre-action listener: _resource_record_pre_action 10:44:44 INFO - Running main action method: create_virtualenv 10:44:44 INFO - Creating virtualenv /builds/slave/test/build/venv 10:44:44 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 10:44:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:44:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:44:44 INFO - Using real prefix '/tools/python27' 10:44:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:44:45 INFO - Installing distribute.............................................................................................................................................................................................done. 10:44:47 INFO - Installing pip.................done. 10:44:48 INFO - Return code: 0 10:44:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:44:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:44:48 INFO - Reading from file tmpfile_stdout 10:44:48 INFO - Output received: 10:44:48 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) 10:44:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:44:48 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')]} 10:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:48 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')]} 10:44:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:48 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 0x10a7f7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a76d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6404ca390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a60bd30>, '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 0x10a471db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a603b20>, '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.VjQh7eVbzu/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.6X3MyeUUqa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 10:44:48 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 10:44:48 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 10:44:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VjQh7eVbzu/Render', 10:44:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:44:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:44:48 INFO - 'HOME': '/Users/cltbld', 10:44:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:44:48 INFO - 'LOGNAME': 'cltbld', 10:44:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:48 INFO - 'MOZ_NO_REMOTE': '1', 10:44:48 INFO - 'NO_EM_RESTART': '1', 10:44:48 INFO - 'PAGER': '/bin/cat', 10:44:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:44:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:48 INFO - 'PWD': '/builds/slave/test', 10:44:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:44:48 INFO - 'SHELL': '/bin/bash', 10:44:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6X3MyeUUqa/Listeners', 10:44:48 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 10:44:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:44:48 INFO - 'USER': 'cltbld', 10:44:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:44:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:44:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:48 INFO - 'XPC_FLAGS': '0x0', 10:44:48 INFO - 'XPC_SERVICE_NAME': '0', 10:44:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:44:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:48 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 10:44:48 INFO - Cleaning up... 10:44:48 INFO - Return code: 0 10:44:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:44:48 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')]} 10:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:48 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')]} 10:44:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:48 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 0x10a7f7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a76d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6404ca390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a60bd30>, '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 0x10a471db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a603b20>, '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.VjQh7eVbzu/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.6X3MyeUUqa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 10:44:48 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 10:44:48 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 10:44:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VjQh7eVbzu/Render', 10:44:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:44:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:44:48 INFO - 'HOME': '/Users/cltbld', 10:44:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:44:48 INFO - 'LOGNAME': 'cltbld', 10:44:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:48 INFO - 'MOZ_NO_REMOTE': '1', 10:44:48 INFO - 'NO_EM_RESTART': '1', 10:44:48 INFO - 'PAGER': '/bin/cat', 10:44:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:44:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:48 INFO - 'PWD': '/builds/slave/test', 10:44:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:44:48 INFO - 'SHELL': '/bin/bash', 10:44:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6X3MyeUUqa/Listeners', 10:44:48 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 10:44:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:44:48 INFO - 'USER': 'cltbld', 10:44:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:44:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:44:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:48 INFO - 'XPC_FLAGS': '0x0', 10:44:48 INFO - 'XPC_SERVICE_NAME': '0', 10:44:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:44:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:48 INFO - Downloading/unpacking psutil>=3.1.1 10:44: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 10:44: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 10:44: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 10:44: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 10:44: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 10:44: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 10:44:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:44:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:44:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:44:52 INFO - Installing collected packages: psutil 10:44:52 INFO - Running setup.py install for psutil 10:44:52 INFO - building 'psutil._psutil_osx' extension 10:44:52 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 10:44:52 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 10:44:52 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 10:44:52 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 10:44:52 INFO - building 'psutil._psutil_posix' extension 10:44:52 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 10:44:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:44:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:44:52 INFO - ^ 10:44:52 INFO - 1 warning generated. 10:44:52 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 10:44:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:44:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:44:53 INFO - Successfully installed psutil 10:44:53 INFO - Cleaning up... 10:44:53 INFO - Return code: 0 10:44:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a7f7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a76d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6404ca390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a60bd30>, '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 0x10a471db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a603b20>, '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.VjQh7eVbzu/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.6X3MyeUUqa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 10:44:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:44:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:44:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VjQh7eVbzu/Render', 10:44:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:44:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:44:53 INFO - 'HOME': '/Users/cltbld', 10:44:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:44:53 INFO - 'LOGNAME': 'cltbld', 10:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:53 INFO - 'MOZ_NO_REMOTE': '1', 10:44:53 INFO - 'NO_EM_RESTART': '1', 10:44:53 INFO - 'PAGER': '/bin/cat', 10:44:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:53 INFO - 'PWD': '/builds/slave/test', 10:44:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:44:53 INFO - 'SHELL': '/bin/bash', 10:44:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6X3MyeUUqa/Listeners', 10:44:53 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 10:44:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:44:53 INFO - 'USER': 'cltbld', 10:44:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:44:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:53 INFO - 'XPC_FLAGS': '0x0', 10:44:53 INFO - 'XPC_SERVICE_NAME': '0', 10:44:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:44: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 10:44: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 10:44: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 10:44: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 10:44: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 10:44: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 10:44:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:44:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:44:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:44:55 INFO - Installing collected packages: mozsystemmonitor 10:44:55 INFO - Running setup.py install for mozsystemmonitor 10:44:56 INFO - Successfully installed mozsystemmonitor 10:44:56 INFO - Cleaning up... 10:44:56 INFO - Return code: 0 10:44:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:44:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a7f7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a76d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6404ca390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a60bd30>, '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 0x10a471db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a603b20>, '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.VjQh7eVbzu/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.6X3MyeUUqa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 10:44:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:44:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:44:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VjQh7eVbzu/Render', 10:44:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:44:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:44:56 INFO - 'HOME': '/Users/cltbld', 10:44:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:44:56 INFO - 'LOGNAME': 'cltbld', 10:44:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:56 INFO - 'MOZ_NO_REMOTE': '1', 10:44:56 INFO - 'NO_EM_RESTART': '1', 10:44:56 INFO - 'PAGER': '/bin/cat', 10:44:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:44:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:56 INFO - 'PWD': '/builds/slave/test', 10:44:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:44:56 INFO - 'SHELL': '/bin/bash', 10:44:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6X3MyeUUqa/Listeners', 10:44:56 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 10:44:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:44:56 INFO - 'USER': 'cltbld', 10:44:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:44:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:44:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:56 INFO - 'XPC_FLAGS': '0x0', 10:44:56 INFO - 'XPC_SERVICE_NAME': '0', 10:44:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:44:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:56 INFO - Downloading/unpacking jsonschema==2.5.1 10:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:44:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:59 INFO - Downloading functools32-3.2.3-2.tar.gz 10:44:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:44:59 INFO - warning: no files found matching '*.txt' 10:44:59 INFO - no previously-included directories found matching 'build' 10:44:59 INFO - no previously-included directories found matching 'dist' 10:44:59 INFO - no previously-included directories found matching '.git*' 10:44:59 INFO - Installing collected packages: jsonschema, functools32 10:44:59 INFO - Running setup.py install for functools32 10:44:59 INFO - warning: no files found matching '*.txt' 10:44:59 INFO - no previously-included directories found matching 'build' 10:44:59 INFO - no previously-included directories found matching 'dist' 10:44:59 INFO - no previously-included directories found matching '.git*' 10:44:59 INFO - Successfully installed jsonschema functools32 10:44:59 INFO - Cleaning up... 10:44:59 INFO - Return code: 0 10:44:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:44: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')]} 10:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44: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')]} 10:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a7f7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a76d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6404ca390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a60bd30>, '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 0x10a471db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a603b20>, '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.VjQh7eVbzu/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.6X3MyeUUqa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 10:44:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:44:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:44:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VjQh7eVbzu/Render', 10:44:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:44:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:44:59 INFO - 'HOME': '/Users/cltbld', 10:44:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:44:59 INFO - 'LOGNAME': 'cltbld', 10:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:59 INFO - 'MOZ_NO_REMOTE': '1', 10:44:59 INFO - 'NO_EM_RESTART': '1', 10:44:59 INFO - 'PAGER': '/bin/cat', 10:44:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:59 INFO - 'PWD': '/builds/slave/test', 10:44:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:44:59 INFO - 'SHELL': '/bin/bash', 10:44:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6X3MyeUUqa/Listeners', 10:44:59 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 10:44:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:44:59 INFO - 'USER': 'cltbld', 10:44:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:44:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:59 INFO - 'XPC_FLAGS': '0x0', 10:44:59 INFO - 'XPC_SERVICE_NAME': '0', 10:44:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:45:00 INFO - Cleaning up... 10:45:00 INFO - Return code: 0 10:45:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:45:00 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')]} 10:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:00 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')]} 10:45:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:00 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 0x10a7f7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a76d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6404ca390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a60bd30>, '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 0x10a471db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a603b20>, '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.VjQh7eVbzu/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.6X3MyeUUqa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 10:45:00 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 10:45:00 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 10:45:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VjQh7eVbzu/Render', 10:45:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:00 INFO - 'HOME': '/Users/cltbld', 10:45:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:00 INFO - 'LOGNAME': 'cltbld', 10:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:00 INFO - 'MOZ_NO_REMOTE': '1', 10:45:00 INFO - 'NO_EM_RESTART': '1', 10:45:00 INFO - 'PAGER': '/bin/cat', 10:45:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:00 INFO - 'PWD': '/builds/slave/test', 10:45:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:00 INFO - 'SHELL': '/bin/bash', 10:45:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6X3MyeUUqa/Listeners', 10:45:00 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 10:45:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:00 INFO - 'USER': 'cltbld', 10:45:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:00 INFO - 'XPC_FLAGS': '0x0', 10:45:00 INFO - 'XPC_SERVICE_NAME': '0', 10:45:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:00 INFO - Downloading/unpacking blobuploader==1.2.4 10:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:02 INFO - Downloading blobuploader-1.2.4.tar.gz 10:45:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:45:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:45: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 10:45: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 10:45: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 10:45: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 10:45: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 10:45: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 10:45:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:45:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:45:03 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 10:45:03 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 10:45:03 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 10:45:03 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 10:45:03 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 10:45:03 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 10:45:03 INFO - Downloading docopt-0.6.1.tar.gz 10:45:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:45:04 INFO - Installing collected packages: blobuploader, requests, docopt 10:45:04 INFO - Running setup.py install for blobuploader 10:45:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:45:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:45:04 INFO - Running setup.py install for requests 10:45:04 INFO - Running setup.py install for docopt 10:45:04 INFO - Successfully installed blobuploader requests docopt 10:45:04 INFO - Cleaning up... 10:45:04 INFO - Return code: 0 10:45:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a7f7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a76d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6404ca390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a60bd30>, '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 0x10a471db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a603b20>, '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.VjQh7eVbzu/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.6X3MyeUUqa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 10:45:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:45:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:45:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VjQh7eVbzu/Render', 10:45:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:04 INFO - 'HOME': '/Users/cltbld', 10:45:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:04 INFO - 'LOGNAME': 'cltbld', 10:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:04 INFO - 'MOZ_NO_REMOTE': '1', 10:45:04 INFO - 'NO_EM_RESTART': '1', 10:45:04 INFO - 'PAGER': '/bin/cat', 10:45:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:04 INFO - 'PWD': '/builds/slave/test', 10:45:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:04 INFO - 'SHELL': '/bin/bash', 10:45:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6X3MyeUUqa/Listeners', 10:45:04 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 10:45:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:04 INFO - 'USER': 'cltbld', 10:45:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:04 INFO - 'XPC_FLAGS': '0x0', 10:45:04 INFO - 'XPC_SERVICE_NAME': '0', 10:45:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:45:05 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-YunTrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:45:05 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-BMXDvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:45:05 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-6sSRAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:45:05 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-n8Nbab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:45:05 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-9cY3LT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:45:05 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-7tPdN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:45:05 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-3PF0YJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:45:05 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-rk5zJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:45:06 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-9uhSZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:45:06 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-ty53pH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:45:06 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-pmi4aH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:45:06 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-uFMzPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:45:06 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-2lz6ew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:45:06 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-YcLM1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:45:06 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-yZNoBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:45:06 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-JWxMEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:45:06 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-MlKpzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:45:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:45:06 INFO - Running setup.py install for manifestparser 10:45:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:45:07 INFO - Running setup.py install for mozcrash 10:45:07 INFO - Running setup.py install for mozdebug 10:45:07 INFO - Running setup.py install for mozdevice 10:45:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:45:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:45:07 INFO - Running setup.py install for mozfile 10:45:07 INFO - Running setup.py install for mozhttpd 10:45:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:45:07 INFO - Running setup.py install for mozinfo 10:45:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:45:08 INFO - Running setup.py install for mozInstall 10:45:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:45:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:45:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:45:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:45:08 INFO - Running setup.py install for mozleak 10:45:08 INFO - Running setup.py install for mozlog 10:45:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:45:08 INFO - Running setup.py install for moznetwork 10:45:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:45:08 INFO - Running setup.py install for mozprocess 10:45:08 INFO - Running setup.py install for mozprofile 10:45:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:45:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:45:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:45:08 INFO - Running setup.py install for mozrunner 10:45:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:45:09 INFO - Running setup.py install for mozscreenshot 10:45:09 INFO - Running setup.py install for moztest 10:45:09 INFO - Running setup.py install for mozversion 10:45:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:45:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:45:09 INFO - Cleaning up... 10:45:09 INFO - Return code: 0 10:45:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:45:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a7f7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a76d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6404ca390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a60bd30>, '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 0x10a471db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a603b20>, '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.VjQh7eVbzu/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.6X3MyeUUqa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 10:45:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:45:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:45:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VjQh7eVbzu/Render', 10:45:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:09 INFO - 'HOME': '/Users/cltbld', 10:45:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:09 INFO - 'LOGNAME': 'cltbld', 10:45:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:09 INFO - 'MOZ_NO_REMOTE': '1', 10:45:09 INFO - 'NO_EM_RESTART': '1', 10:45:09 INFO - 'PAGER': '/bin/cat', 10:45:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:09 INFO - 'PWD': '/builds/slave/test', 10:45:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:09 INFO - 'SHELL': '/bin/bash', 10:45:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6X3MyeUUqa/Listeners', 10:45:09 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 10:45:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:09 INFO - 'USER': 'cltbld', 10:45:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:09 INFO - 'XPC_FLAGS': '0x0', 10:45:09 INFO - 'XPC_SERVICE_NAME': '0', 10:45:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:45:09 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-aZW0Rj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:45:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:45:09 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-H9OU1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:45:10 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)) 10:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:45:10 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-QBuDMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:45:10 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)) 10:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:45:10 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-m7bzY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:45:10 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)) 10:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:45:10 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-qxFYx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:45:10 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)) 10:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:45:10 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-JStLHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:45:10 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)) 10:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:45:10 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-rJQh1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:45:10 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-0i7TGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:45:10 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-3jG05E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:45:10 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-NWEcxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:45:10 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-dN8ZGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:45:11 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)) 10:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:45:11 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-r1HDgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:45:11 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)) 10:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:45:11 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-HWwR9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:45:11 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)) 10:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:45:11 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-CRZmEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:45:11 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)) 10:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:45:11 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-UNsvv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:45:11 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)) 10:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:45:11 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-B82SxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:45:11 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-9bWmyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:45:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:14 INFO - Downloading blessings-1.6.tar.gz 10:45:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:45:14 INFO - Installing collected packages: blessings 10:45:14 INFO - Running setup.py install for blessings 10:45:14 INFO - Successfully installed blessings 10:45:14 INFO - Cleaning up... 10:45:14 INFO - Return code: 0 10:45:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:45:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:45:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:45:14 INFO - Reading from file tmpfile_stdout 10:45:14 INFO - Current package versions: 10:45:14 INFO - blessings == 1.6 10:45:14 INFO - blobuploader == 1.2.4 10:45:14 INFO - docopt == 0.6.1 10:45:14 INFO - functools32 == 3.2.3-2 10:45:14 INFO - jsonschema == 2.5.1 10:45:14 INFO - manifestparser == 1.1 10:45:14 INFO - mozInstall == 1.12 10:45:14 INFO - mozcrash == 1.0 10:45:14 INFO - mozdebug == 0.1 10:45:14 INFO - mozdevice == 0.48 10:45:14 INFO - mozfile == 1.2 10:45:14 INFO - mozhttpd == 0.7 10:45:14 INFO - mozinfo == 0.9 10:45:14 INFO - mozleak == 0.1 10:45:14 INFO - mozlog == 3.4 10:45:14 INFO - moznetwork == 0.27 10:45:14 INFO - mozprocess == 0.23 10:45:14 INFO - mozprofile == 0.28 10:45:14 INFO - mozrunner == 6.13 10:45:14 INFO - mozscreenshot == 0.1 10:45:14 INFO - mozsystemmonitor == 0.3 10:45:14 INFO - moztest == 0.7 10:45:14 INFO - mozversion == 1.4 10:45:14 INFO - psutil == 3.1.1 10:45:14 INFO - requests == 1.2.3 10:45:14 INFO - wsgiref == 0.1.2 10:45:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a7f7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a76d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6404ca390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a60bd30>, '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 0x10a471db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a603b20>, '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.VjQh7eVbzu/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.6X3MyeUUqa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 10:45:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:45:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:45:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VjQh7eVbzu/Render', 10:45:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:14 INFO - 'HOME': '/Users/cltbld', 10:45:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:14 INFO - 'LOGNAME': 'cltbld', 10:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:14 INFO - 'MOZ_NO_REMOTE': '1', 10:45:14 INFO - 'NO_EM_RESTART': '1', 10:45:14 INFO - 'PAGER': '/bin/cat', 10:45:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:14 INFO - 'PWD': '/builds/slave/test', 10:45:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:14 INFO - 'SHELL': '/bin/bash', 10:45:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6X3MyeUUqa/Listeners', 10:45:14 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 10:45:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:14 INFO - 'USER': 'cltbld', 10:45:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:14 INFO - 'XPC_FLAGS': '0x0', 10:45:14 INFO - 'XPC_SERVICE_NAME': '0', 10:45:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:15 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)) 10:45:15 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)) 10:45:15 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)) 10:45:15 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)) 10:45:15 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)) 10:45:15 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)) 10:45:15 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)) 10:45:15 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)) 10:45:15 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)) 10:45:15 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)) 10:45:15 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)) 10:45:15 INFO - Cleaning up... 10:45:15 INFO - Return code: 0 10:45:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:45:15 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')]} 10:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:15 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')]} 10:45:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:15 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 0x10a7f7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a76d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6404ca390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a60bd30>, '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 0x10a471db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a603b20>, '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.VjQh7eVbzu/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.6X3MyeUUqa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 10:45:15 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 10:45:15 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 10:45:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VjQh7eVbzu/Render', 10:45:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:15 INFO - 'HOME': '/Users/cltbld', 10:45:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:15 INFO - 'LOGNAME': 'cltbld', 10:45:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:15 INFO - 'MOZ_NO_REMOTE': '1', 10:45:15 INFO - 'NO_EM_RESTART': '1', 10:45:15 INFO - 'PAGER': '/bin/cat', 10:45:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:15 INFO - 'PWD': '/builds/slave/test', 10:45:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:15 INFO - 'SHELL': '/bin/bash', 10:45:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6X3MyeUUqa/Listeners', 10:45:15 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 10:45:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:15 INFO - 'USER': 'cltbld', 10:45:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:15 INFO - 'XPC_FLAGS': '0x0', 10:45:15 INFO - 'XPC_SERVICE_NAME': '0', 10:45:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:45:15 INFO - Cleaning up... 10:45:15 INFO - Return code: 0 10:45:15 INFO - Running post-action listener: _resource_record_post_action 10:45:15 INFO - Running post-action listener: _start_resource_monitoring 10:45:15 INFO - Starting resource monitoring. 10:45:15 INFO - [mozharness: 2016-11-14 18:45:15.459189Z] Finished create-virtualenv step (success) 10:45:15 INFO - [mozharness: 2016-11-14 18:45:15.460213Z] Running install step. 10:45:15 INFO - Running pre-action listener: _resource_record_pre_action 10:45:15 INFO - Running main action method: install 10:45:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:45:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:45:15 INFO - Reading from file tmpfile_stdout 10:45:15 INFO - Detecting whether we're running mozinstall >=1.0... 10:45:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:45:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:45:15 INFO - Reading from file tmpfile_stdout 10:45:15 INFO - Output received: 10:45:15 INFO - Usage: mozinstall [options] installer 10:45:15 INFO - Options: 10:45:15 INFO - -h, --help show this help message and exit 10:45:15 INFO - -d DEST, --destination=DEST 10:45:15 INFO - Directory to install application into. [default: 10:45:15 INFO - "/builds/slave/test"] 10:45:15 INFO - --app=APP Application being installed. [default: firefox] 10:45:15 INFO - mkdir: /builds/slave/test/build/application 10:45:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:45:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 10:45:47 INFO - Reading from file tmpfile_stdout 10:45:47 INFO - Output received: 10:45:47 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 10:45:47 INFO - Running post-action listener: _resource_record_post_action 10:45:47 INFO - [mozharness: 2016-11-14 18:45:47.852708Z] Finished install step (success) 10:45:47 INFO - [mozharness: 2016-11-14 18:45:47.852847Z] Running run-tests step. 10:45:47 INFO - Running pre-action listener: _resource_record_pre_action 10:45:47 INFO - Running main action method: run_tests 10:45:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:45:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:45:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:45:47 INFO - 2016-11-14 10:45:47.867 screenresolution[1987:10212] starting screenresolution argv=screenresolution get 10:45:47 INFO - 2016-11-14 10:45:47.870 screenresolution[1987:10212] Display 0: 1600x1200x32@60 10:45:47 INFO - 2016-11-14 10:45:47.876 screenresolution[1988:10214] starting screenresolution argv=screenresolution list 10:45:47 INFO - Available Modes on Display 0 10:45:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:45:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:45:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:45:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:45:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:45:48 INFO - Intel Iris: 10:45:48 INFO - Chipset Model: Intel Iris 10:45:48 INFO - Type: GPU 10:45:48 INFO - Bus: Built-In 10:45:48 INFO - VRAM (Dynamic, Max): 1536 MB 10:45:48 INFO - Vendor: Intel (0x8086) 10:45:48 INFO - Device ID: 0x0a2e 10:45:48 INFO - Revision ID: 0x0009 10:45:48 INFO - Displays: 10:45:48 INFO - Display: 10:45:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:45:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:45:48 INFO - Display Serial Number: 1600x1200 60 10:45:48 INFO - Main Display: Yes 10:45:48 INFO - Mirror: Off 10:45:48 INFO - Online: Yes 10:45:48 INFO - Rotation: Supported 10:45:48 INFO - Return code: 0 10:45:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:45:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:45:48 INFO - Python 2.7.3 10:45:48 INFO - Return code: 0 10:45:48 INFO - grabbing minidump binary from tooltool 10:45:48 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')]} 10:45:48 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 0x10a60bd30>, '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 0x10a471db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a603b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:45:48 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 10:45:48 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 10:45:48 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 10:45:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:45:48 INFO - Return code: 0 10:45:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:45:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:45:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:45:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:45:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:45:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0162', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:45:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0162 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:45:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VjQh7eVbzu/Render', 10:45:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:45:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:45:48 INFO - 'HOME': '/Users/cltbld', 10:45:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:45:48 INFO - 'LOGNAME': 'cltbld', 10:45:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:45:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:45:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:48 INFO - 'MOZ_NO_REMOTE': '1', 10:45:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:45:48 INFO - 'NO_EM_RESTART': '1', 10:45:48 INFO - 'PAGER': '/bin/cat', 10:45:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:45:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:48 INFO - 'PWD': '/builds/slave/test', 10:45:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:45:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:45:48 INFO - 'SHELL': '/bin/bash', 10:45:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6X3MyeUUqa/Listeners', 10:45:48 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 10:45:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:45:48 INFO - 'USER': 'cltbld', 10:45:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:45:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:45:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:48 INFO - 'XPC_FLAGS': '0x0', 10:45:48 INFO - 'XPC_SERVICE_NAME': '0', 10:45:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:45:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0162', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:45:48 INFO - mozversion application_buildid: 20161114074144 10:45:48 INFO - mozversion application_changeset: 8cdff71808a0e11361bca7f218658c4343c730ca 10:45:48 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:45:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:45:48 INFO - mozversion application_name: Firefox 10:45:48 INFO - mozversion application_remotingname: firefox-dev 10:45:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:45:48 INFO - mozversion application_vendor: Mozilla 10:45:48 INFO - mozversion application_version: 52.0a2 10:45:48 INFO - mozversion platform_buildid: 20161114074144 10:45:48 INFO - mozversion platform_changeset: 8cdff71808a0e11361bca7f218658c4343c730ca 10:45:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:45:48 INFO - mozversion platform_version: 52.0a2 10:45:48 INFO - using testdate: 1479149148 10:45:48 INFO - actual date: 1479149148 10:45:48 INFO - starting webserver on 'localhost:49401' 10:45:48 INFO - SUITE-START | Running 2 tests 10:45:48 INFO - TEST-START | dromaeo_css 10:45:48 INFO - operating with platform_type : mac_ 10:45:48 INFO - Initialising browser for dromaeo_css test... 10:45:48 INFO - TEST-INFO | started process 1998 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmpCRhMCV/profile http://localhost:49401/getInfo.html) 10:45:50 ERROR - PROCESS | 1998 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 10:45:51 INFO - PROCESS | 1998 | __metrics Screen width/height:1600/1200 10:45:51 INFO - PROCESS | 1998 | colorDepth:24 10:45:51 INFO - PROCESS | 1998 | Browser inner width/height: 1024/689 10:45:51 INFO - PROCESS | 1998 | __metrics 10:45:51 ERROR - PROCESS | 1998 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 10:45:52 INFO - TEST-INFO | 1998: exit 0 10:45:52 INFO - Browser initialized. 10:45:52 INFO - Running cycle 1/1 for dromaeo_css test... 10:45:52 INFO - TEST-INFO | started process 2000 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmpCRhMCV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:46:04 INFO - PROCESS | 2000 | RSS: Main: 224477184 10:46:04 INFO - PROCESS | 2000 | 10:46:53 INFO - PROCESS | 2000 | 1479149213855 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:49:07 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49401/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49401/tests/dromaeo/cssquery-ext.html) 10:49:09 INFO - PROCESS | 2000 | RSS: Main: 240148480 10:49:09 INFO - PROCESS | 2000 | 10:52:12 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49401/tests/dromaeo/cssquery-ext.html (next: http://localhost:49401/tests/dromaeo/cssquery-jquery.html) 10:52:12 INFO - PROCESS | 2000 | RSS: Main: 251502592 10:52:12 INFO - PROCESS | 2000 | 10:55:14 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49401/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49401/tests/dromaeo/cssquery-mootools.html) 10:55:15 INFO - PROCESS | 2000 | RSS: Main: 255344640 10:55:15 INFO - PROCESS | 2000 | 10:58:17 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49401/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49401/tests/dromaeo/cssquery-prototype.html) 10:58:17 INFO - PROCESS | 2000 | RSS: Main: 254820352 10:58:17 INFO - PROCESS | 2000 | 11:01:20 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49401/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49401/tests/dromaeo/cssquery-yui.html) 11:01:21 INFO - PROCESS | 2000 | RSS: Main: 258207744 11:01:21 INFO - PROCESS | 2000 | 11:04:23 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49401/tests/dromaeo/cssquery-yui.html (next: http://localhost:49401/tests/dromaeo/cssquery-dojo.html) 11:04:24 INFO - PROCESS | 2000 | RSS: Main: 259522560 11:04:24 INFO - PROCESS | 2000 | 11:04:24 INFO - PROCESS | 2000 | __start_tp_report 11:04:24 INFO - PROCESS | 2000 | _x_x_mozilla_page_load 11:04:24 INFO - PROCESS | 2000 | _x_x_mozilla_page_load_details 11:04:24 INFO - PROCESS | 2000 | |i|pagename|runs| 11:04:24 INFO - PROCESS | 2000 | |0;dojo.html;3330.2839889423776;3363.9495407568907;3410;3456.706179974703;3490.4240800267958;5993.640381577108;6024.246969128859;6029.3970602939735;6076.6050206736645;6082.787102451415;6028.577999540034;6074;6118.816435506931;6132.202813634232;6150.81547553573;4484.686071974963;5409.26974858393;5484.204790305404;5500.669959802404;5559.527440167591;5514.558835293167;5527.447255274481;5532.031894418481;5533.667979921198;5557.555395568365;5368.489993450636;5383.327084114486;5515.062439385314;5522.282103326562;5526.751296191681;5386.78452861885;5417.6207665463435;5444.128939369702;5472.288602481692;5521.033819081685;4522.525134860858;5355.6251062425645;5508.504234618904;5525.281713377275;5559.444055594448;6048.909266361008;6118.724657390384;6139.662318572477;6172.321044685081;6193.071039344134;5173.3016042834115;6144.293406258293;6279.058141278799;6294.898392781291;6339.080833279195;6292.5595208335435;6302.96848515759;6355.332690067523;6441.742330306782;6443.806685799434;6175.59858609189;6180.907286390753;6181.041938499539;6198.442140207403;6198.6280823149855;5678.3186017678145;6301.77943771975;6497.610143391412;6509.121268628674;6511.772087976898;5861.325947516005;6215.96892015537;6219.40915613016;6287.717052732638;6333.841653958688;6380.680965951684;6392.264889537762;6393.328700486475;6395.392437718409;6402.743890244338;6168.519555306694;6224.688765561704;6278;6289;6314.179156709598;5521.5306698931045;6198.101275315054;6215.627062376272;6271.560990730605;6276.874462510724;4313.417688611998;5027.321311622957;5074.923876141861;5095.439501654815;5125.4874512549195;4580.404547408815;4582.770861456914;4594.035252596926;4594.540545945379;4596.448426188812;6021.2774467063355;6034.275886893513;6121.4490695837585;6140.504248697391;6185.474234690012;6259.530535209787;6282.780102696383;6283.5287353448675;6292.244930608264;6297.4647154992335;6058.091286307089;6156.384361563897;6166.784162554289;6185.783497577563;6190.442860142609;5519.724013799294;5530.419305972815;5536.252605898233;5562.22128901946;5571;6580.76967306142;6597.208334999927;6611.074449577063;6612.338766123349;6637.800865974028;6214.098955651496;6284.025975973731;6397;6413.8396540085005;6427.55007149495;5776.740046697824;6478.2550006749825;6510.576812507172;6594.142761440982;6603.108580341785;6315.652639104894;6336.841578960563;6345.777897773556;6348.650824204713;6366.777162799465;6195.349488303663;6400.871982560416;6420.486361091008;6422.903656445251;6426.100345951477;6096.359882212481;6159.6612186330185;6184.6598437086395;6188.81433556994;6210.689465526615;6231.065340198825;6259.3427690091885;6261.749530018748;6284.402981716729;6297.1813664223355;6134.693265336626;6236.6258024518675;6250.062490626442;6268.4671802897265;6292.874142517216;6168.722407491763;6190.442860142609;6202.224721909762;6234.688265586793;6251.718672659832;6207.317195108625;6253.937460625336;6259.906101408574;6270.686465676789;6293.276273228455 11:04:24 INFO - PROCESS | 2000 | |1;ext.html;440.7641911577307;482.3271536206991;486.734729572383;490.409057086211;536.4903341825266;36307.81846090769;40301.19397612046;40450.7977460113;42789.572104278945;42874.35688464668;41695.123719432624;42158.367624485654;42213.15573688532;42257.78871105648;42277.52028678989;8095.919040809605;9226.815463690738;9288.953555232249;9411.90588094117;9455.574499147555;9452.527373631325;9519.80960380792;9522.333436659437;9524.095210954949;9567.186789122932;9491.19324857388;9523.904760952371;9555.331126821126;9571.282153838456;9581.952090239574;8556.657733690645;9474.763130921747;9493.477858717768;9523.238140948743;9543.997880222616;9365.625374984993;9446.763830904214;9450.149486546245;9468;9468.668596599086;39468.407973880414;39772.403413948814;39810.20379592421;39816;39852.800735996425;3199.9680003200137;3325.93348133036;3341.933161336784;3363.915902102467;3367.107716455141;29280;29414.70585294141;30196.24509387261;30633.540496892565;31440.213994650087;3096.551000104972;3177.205698575356;3182.140821978053;3185.952210716841;3200.8399580021137;475757;477748;480188;481380.9999999965;481611;62140.37859621346;62465;62486;62559.37440625626;62630.68684656639;64064.67967660225;64780.35219647743;65054.674726626065;65274.694506110565;65465.01802472967;16236.188190590423;16262.430814921421;16300.429484968206;16511.256993435323;16512.917435412746;12568.120231583884;12623.558175463999;12643.43104560297;12662.986961043094;12754.426050827735;18061.764104362093;18612.44162675122;18677.626447470975;18722.906385467984;18819.81180188208;2771.7921155913386;3226.6450690424035;7591.848163036709;7616.05790523413;7918.960405197937;854.4702284583474;937.1612406895927;1016.2632091733582;1077.9191560632985;1103.194667892443;25908.74091259101;30327.241818954702;30361.392772144434;30646.84676576603;30988;947.3889341374775;1015.8425444056184;1023.22746326523;1029.4749677664295;1073.1790180511914;14876.330565124596;15050.322735476711;15712.764308535381;15888.126153061692;16025.358985640443;689306;691660;692066;694602.0539794639;697820;47589.5241047592;56866.715666421405;57386.13920791192;57480.71259643675;57610;1353.3503918119359;1354.9905320536263;1381.0332767063096;1387.036009973059;1388.1532265318149;29078.12765617035;29811.70188298089;29966;30135.849320753256;30618.540721888745;50134;50192.49807501878;50581;50674.49325506698;50675.23987140269;633608;635446;636100;636222;641444;21417;26280.60579091277;26490.470190595694;26809.19572412831;27163.185104446897;45153.87115322143;46900.7654961723;47392.763036184595;47503.762481187376;47576.810579735786;37369.25261494809;38103;38909;40457;40648.79675601603;37981.81009095047;37982.62017379901;38350.80824595859;39123;39474.80262598669;37268.627313726516;38196.42705359366;38245.80877095597;38486.037849053995;39692;26574.86712566425;28081.859590701915;32335.514967275038;33460.66539334576;34784.82607586946;22975.195868144536;25368.11211607585;25897.482050359264;26020.2760571239;26021.349466262738 11:04:24 INFO - PROCESS | 2000 | |2;jquery.html;378.36812523086445;379.91641838795465;388.19255947628926;391.8295541439476;407.4723233412732;17713.380031698893;19681.901590492063;20128.798712012875;20209.090590923406;20284.797152028474;15769.60575985601;19299.807001929978;19838.50403739907;20101.994900255002;20173.899130504327;4826.34844296019;5602.327720673525;5895.9705201473935;5903.144044113601;5909.172715819789;5750;5909.940900590982;5919.1417244499735;5922.674252916088;5926.199963005004;5552.305961754781;5801.6519008859395;5838.854028649275;5858.5898987070705;5862.530997520188;5023.196288593807;5760.884782304352;5826.417358264182;5840.386759390267;5848.941510584925;5069.569086627641;5110.795568177268;5365;5410.5401040911565;5462;12870.099093063489;12954.222746635232;13011.479540818356;13102.934485327607;13174.209547427185;2104.5580428110115;2118.2374345235703;2159.7732238115086;2174;2223.321886824518;8135.186481351877;9783.608655653765;10224.079832815009;10251.231157663131;12561.309127997956;1739.9826001739948;1822.9426932379188;1828.7074068149032;1836.2563161919445;1895.668258054835;104987.47506262496;122555;126733.73266267404;128221;129437.35281323627;11388.943055284837;11397.601083962021;11658.260308827419;11721.941390292994;12130.33283169434;14779.408823646934;14794.260286985607;14794.852051479562;14796.186209758567;14798.926005369904;8210.917890821134;8438.113998030118;8467.576621168917;8556.74329770108;8565.785855353666;8355.749327520183;8361.456505327134;8361.498310101413;8488.787780305418;8526.57367131641;3839.846406143779;4545.704529205591;4559.179347717442;4567.287267274772;4658.906821863544;1635.64833560785;1957.4323446200726;1963.126408748122;1977.4166620846884;2024.6861736430876;793.9007624046994;881.6473410635668;923.4690053219425;949.1647350331664;971.3637567393368;18678.159482823306;20695.379138625864;20866.47833804167;20953.26663566768;21051.473713156985;879.4459490521059;884.9646014159362;897.6095398501673;944.4899754132691;1015.939043657383;10346.637867674595;10357.792844143074;10382.636607718694;10859.728506787393;10978.286411383395;484189;504094.60783333844;523987;547659.3851981786;661105;101130;101160;126447.3677631606;136769;137694;935.5743136872707;998.4758002048983;1007.7833265847878;1009.3641006166215;1009.808136454086;17952.281908724028;18262.634747305245;18603.813961860207;18633.720494192326;18977.620447591245;51962.74018630034;52193;52264.466941632294;53673.731631341594;54463;74143;75656.62171689107;76460;77004;79022.20977790149;6498.642574658439;7757.418193635613;7823.100343460347;7921.485103468256;8073.515589064675;10149.84775228387;12085.395730213279;12089.758204835678;12228.449719762453;12466.937665311616;10329.431881246604;10408;10566.366018038942;10604.734881628021;10823.134149268197;10463.581456741646;10477.37135771856;10694.786104277715;10808.837867431837;10936.945315273373;10591.8940810594;10678.46607669629;10943.233973621771;11017;11082.667519974091;7865.921340786519;7912.683492660229;7913.683452661829;8285.83428331442;8293.21214484623;8110.594470276581;9731.659391921248;10712.839307410239;11087.611933582286;11198.720031999264 11:04:24 INFO - PROCESS | 2000 | |3;mootools.html;1255.8618551959282;1432.4485073246797;1472.34480656108;1598.3287019451836;1797.829206225409;7505.549667019969;7740.458167928247;8025.8394832103395;8431.957840210798;8472.91527084729;7839.176886426914;8131.878021829677;8136.959315203416;8229.83540329193;8240.752777416687;2302.297799171252;2335.252719129879;2335.392797872557;2340.0756701103055;2341.3327201747506;2287.874166920819;2312.0867257433306;2327.0924339507606;2332.5917964356254;2360.8111351091957;2293;2303.435658263728;2313;2319.3621754017695;2319.675245465636;2290.5647926893835;2302.574023805593;2313.59260608541;2324.500232450023;2330.545543618995;2330.8718020508863;2343.121329501437;2348.4011577047913;2349.1425629645228;2354.9991253717103;8111.310538604226;8174.100848906615;8207.015158180997;8272.3795715321;8390.958045209796;5009.373828271466;5160.277561141444;5171.3535808024;5177;5190.662606930575;3257.8696852125886;3399.167204035027;3471.2189757304404;3564.572251329857;3569.1434055826676;1016.8983101689846;1039.563383378975;1078.1751959750798;1080.4543705428787;1105.6959336182533;9907;9997.250206234488;10800.351978881292;10848.240623156382;10879.184061195441;4440;4524.276115821453;4674.719516829001;4721.079389519079;4745.549172828576;9273.768155796024;9371.156595906401;9375.5312234388;9376.343655944154;9426.811463770686;4260.25445547028;5129.102407078746;5145.588352931756;5152.9742351288005;5158.226266060121;3768.7550309229814;3909.237698648736;4232.513260975027;4342.739435633872;4694.624430045588;3769.4345848122452;3798.2023775007556;3861.1505468796818;3887.3391523441082;3893.3381325174787;1268.0679700420185;1277.9680507987375;1283.7432513497151;1289.9419526121346;1298.6688394459352;749.3855038868076;794.2772077409529;901.2159421303508;913.8583519554479;918.5499105438287;5054.519820617035;5649.858753531194;5675.914861277084;5837.737301821428;5845.503132233723;901.9954900225457;902.4089221559889;961.3895176562933;970.5438443931341;987.8863930647924;3652.196516766307;3876.980615096963;3990.7206495545033;3994.6804255659476;4008.7795171265275;9604.567794449267;10056.798864022825;10078.193744500422;10084.445355505517;10095.242856785624;9392.90607093934;9923.156531694742;9936.701898943043;9973.351732137387;10038.996100389902;7565.2812982766545;7883.6058197089915;7890.605469726605;7890.644920978455;7925.128235894047;5439.156930675752;5568.888622227614;5684.516816070515;5741.311042674739;5791.855203619774;9162.679306224516;9228.169464748205;9235.445873247627;9331.813363732552;9422.340436169676;9142;9450;9577.664781732607;9598.760030999281;9635;7126;7340.192578816219;7537.434692397982;7702.345300649507;7877.7636670899965;7785.766427007199;7979.84040319202;7980.321672657889;7983.640736166771;7985.121636620083;7043.542169758949;7105.893411598727;7145.785626431215;7150.463715221484;7226.963865180641;6941.409980151744;6948.6525673715105;6953.061336719478;6969.094017777859;7089.858202836018;6558.081868538504;6560.3111673275525;6601.900971485527;6633.170853643294;6661.566998145105;4836.492168322417;4838.806447742051;4884.120858245407;4903.41159060915;4913.410390753133;4837.588804951619;4892.461829198856;4902.411710594752;4980.975095124646;5003.849884503471 11:04:24 INFO - PROCESS | 2000 | |4;prototype.html;301.90791808498403;306.1916540333518;308.70364450127875;310.94403007458646;315.2497057004329;4811.735354555498;5088.669236499625;5237.5548078413285;5328.470799820151;5368.792021795099;4071.73533720308;4616.722996620205;5217.956408718262;5266.3153790007345;5268.868278293045;4007;4029.697772667047;4041.8383264669524;4051.5745846686114;4062.512498500184;3936.744111632749;4036.757794532323;4066;4086.366613174948;4089.8568550100754;3817.980910095446;3989.36170212766;4026.5369482509595;4080.9387859182134;4096.651784598298;3315.7347412207087;3779.5653499847595;3983.6016398359934;4026.617471340218;4036.4550785643855;3538.1331573764337;3539.893803185883;3546.9113272168142;3552.7335449841366;3586.605473397924;4383.517813040563;4411.911761764747;4733.254712266877;4873.319674179187;5209;3516.4549494828343;3864.091938394475;4526.434195725535;4541.772911354419;4642.558956899089;5649.022842005306;5652.664927692681;5680.204771332017;5693.231413759131;5746.626469279484;3325.9168520786934;3510.4558793387064;3690.280395322913;3805.9429108563395;3829.2959632963343;4754.643401744883;4857.368542089541;5845.223518828522;5852.853678658025;5875.882482350372;3139.9058028259187;3256.299895522474;3305.636379998198;3833.9041523962123;3869.941950870683;3606.6213047630145;3929.4302326162547;3940.862069827542;3941.5270167580074;3946.2699400610977;4253.957460425356;4320.308750599889;4498.685092043525;4574.056026188923;4602.723836569817;4383.802728877208;4693.718376897397;5541.861453463615;5648.8870222595315;5655.349634791969;1194.8446701928694;1212.278694176981;1235.765204611121;1247.9750404991848;1275.5408053100875;786.8001298020564;838.3209600223838;851.2253848997383;861.7418568889492;882.3338379523419;4291.815479907065;4912.557869791736;5026.989204318302;5062.873428164326;5075;4669.875206780906;5463.945360546344;5475.589330800206;5493.587980901449;5516.586256030814;4321.6075380825905;4489.820407183742;4592.346755168137;4662.300654901724;5073.797048118034;2546.668933038693;2646.827956182842;2875.7268059534313;2894.435585060893;2916.2709322669334;5067.1639179535705;5266.868328291824;5304.336957880265;5673.659580425106;5711.259125272953;4866.46468888422;5154.768035438415;5303.549198318109;5558.6942718150085;5628.185907046477;5717.171010203498;6032.366601506867;6127.877442451037;6134.8159555213415;6140.478059364915;5006.824761133488;5940.277319577447;5995.5803093783015;5995.850103747442;6006.699665016644;5535;5835.9708201458725;5877.764889404547;5890.852728681817;5899.203607512931;6150.969245153746;6160.815175544741;6199.845003874939;6216.544464936415;6221.844453888689;3108.098651391071;3391.9830400847836;3661.2677464507738;3677.8712745053795;3867.593902640295;5282.550983166474;5355.705436201047;5454.63629096729;5893.233879595625;5951.613145145551;4979.228219625964;4996.650234483696;5501.3948465667945;5563.248961390161;5641.915371269352;4394.538573449741;5450.31871016123;5678.517326027169;5750.763585829067;5826.552847803848;4907.871189626335;4971.837250795916;5400.486953739389;5612.298462692163;5660.490555849993;5672.468433522843;5679.659220446786;5790.826275211751;5793.94206057934;5817.185594016925;5595.272614560244;5614.326280846324;5663.490285874291;5718.313802343745;5719.628224165416 11:04:24 INFO - PROCESS | 2000 | |5;yui.html;687.2852233676979;698.3679769808324;729.8467321862408;732.4689600039972;756.5044895593387;13750.724985500285;14478.782818257709;14695.485658001986;14715.190664513448;14741.778873316895;13137.868621313784;13221.669458263548;13241.205527668322;13267.601971940858;13283.269420181887;629.2637613991641;654.6301339743054;789.2186735132207;803.441608082383;820.8522465956125;786.8111653203247;794.5431376958243;794.6940427935258;809.4050872608628;809.5426084262402;845.0746432656263;847.478800537668;848.3976376772468;850.6172222499899;851.8637018077109;842.9968337678174;843.6583183810536;846.9407141500097;847.6778824046853;848.0967769325648;504.93183420238165;540.0360356763198;618.4742968476804;633.192679333853;637.4613451633362;11158.721031974184;11920.986716129139;12832.294223817686;13436.865631343659;13564.45742170312;12862.812889637346;13140.408681609351;13242.205467671874;13334.333283335794;13390.799138012937;9227.44635321883;10948.3978381189;11343.886561134366;11428.028617567517;11820.113491488088;3162.304293055524;3594.4788005739283;3645.2527231917393;3697.9630203698157;3737.103095257146;59291;63183.36816631821;71278.2872171282;90360.5481972586;94120;10462.21533384984;10765;10920.945395273131;10949.945250273857;11207.831882521605;21297.254596089064;21390.893045534674;21457.356279311647;21470.604410713255;21488.892555537434;7816.335611472975;7979.082405523439;7993.400494962785;8003.399745019147;8100.079119829277;4205.116925445691;4214.494260688675;4264.976405662619;4310.590493903074;4386.583274588909;3336.299377130781;3430.0567343980106;3432.5880894292845;3438.8452519636676;3442.1050526863196;496.53325873679347;570.2672066394663;615.3938370704852;648.4812150279757;649.4544582550585;534.2467121358866;566.7053132371226;605.6564159565271;627.8712863862897;637.08260105448;8579.871301930476;8700.738977830675;8778.253848422955;8792.296616270683;9145.496997665192;606.548121649374;609.5854818723222;611.9051547010221;616.605372561561;638.635977492834;4049.7772622505454;4095.3242714952294;4151.12826306473;4216.262154123016;4270.679699022524;73957.89063164056;118873;120503.39748301203;122080.38959805144;124670;102787.48606256921;105207;106632.46683766531;106645.9335406636;106723;27352.452950941268;27365.315867103483;27484.862575687395;62335.37664623386;62621.68689156525;8187.590620469072;8189.959050204711;8360.45657032291;8450.45072070338;8511.106333834858;51634;57126.7143664279;57925;59761.70119149376;60149.699251503465;67080;68321.31678683149;72688;74161.25838741544;79787;8316.83366332682;9339.719808405758;10639;10902.727431814268;11307.095432365555;11343.602973895873;11786.882131178578;11950.46222919988;12022.27866328023;12113.212641178296;10414.73963150897;10794.298370605886;10906.182036347464;10954;10974.451277436256;9215.44707317563;10941.28881622692;11474.368909710047;11671.35807530594;11703.590374336858;10242.590296388062;10414.375137491776;10955.945220274167;11067.00396964277;11103.222774405715;9163.908360916306;9383.062170988762;9494.145526902612;9701.6119355225;9826.5086745661;9459.432434053979;9681.957792529309;9687.806243875224;9695.806083878142;9710.902890971 11:04:24 INFO - PROCESS | 2000 | __end_tp_report 11:04:24 INFO - PROCESS | 2000 | __start_cc_report 11:04:24 INFO - PROCESS | 2000 | _x_x_mozilla_cycle_collect,371 11:04:24 INFO - PROCESS | 2000 | __end_cc_report 11:04:24 INFO - PROCESS | 2000 | __startTimestamp1479150264248__endTimestamp 11:04:24 INFO - PROCESS | 2000 | 11:04:24 INFO - PROCESS | 2000 | ------- Summary: start ------- 11:04:24 INFO - PROCESS | 2000 | Number of tests: 6 11:04:24 INFO - PROCESS | 2000 | 11:04:24 INFO - PROCESS | 2000 | [#0] dojo.html Cycles:165 Average:5919.37 Median:6185.78 stddev:663.99 (10.7%) stddev-sans-first:634.20 11:04:24 INFO - PROCESS | 2000 | Values: 3330.3 3363.9 3410.0 3456.7 3490.4 5993.6 6024.2 6029.4 6076.6 6082.8 6028.6 6074.0 6118.8 6132.2 6150.8 4484.7 5409.3 5484.2 5500.7 5559.5 5514.6 5527.4 5532.0 5533.7 5557.6 5368.5 5383.3 5515.1 5522.3 5526.8 5386.8 5417.6 5444.1 5472.3 5521.0 4522.5 5355.6 5508.5 5525.3 5559.4 6048.9 6118.7 6139.7 6172.3 6193.1 5173.3 6144.3 6279.1 6294.9 6339.1 6292.6 6303.0 6355.3 6441.7 6443.8 6175.6 6180.9 6181.0 6198.4 6198.6 5678.3 6301.8 6497.6 6509.1 6511.8 5861.3 6216.0 6219.4 6287.7 6333.8 6380.7 6392.3 6393.3 6395.4 6402.7 6168.5 6224.7 6278.0 6289.0 6314.2 5521.5 6198.1 6215.6 6271.6 6276.9 4313.4 5027.3 5074.9 5095.4 5125.5 4580.4 4582.8 4594.0 4594.5 4596.4 6021.3 6034.3 6121.4 6140.5 6185.5 6259.5 6282.8 6283.5 6292.2 6297.5 6058.1 6156.4 6166.8 6185.8 6190.4 5519.7 5530.4 5536.3 5562.2 5571.0 6580.8 6597.2 6611.1 6612.3 6637.8 6214.1 6284.0 6397.0 6413.8 6427.6 5776.7 6478.3 6510.6 6594.1 6603.1 6315.7 6336.8 6345.8 6348.7 6366.8 6195.3 6400.9 6420.5 6422.9 6426.1 6096.4 6159.7 6184.7 6188.8 6210.7 6231.1 6259.3 6261.7 6284.4 6297.2 6134.7 6236.6 6250.1 6268.5 6292.9 6168.7 6190.4 6202.2 6234.7 6251.7 6207.3 6253.9 6259.9 6270.7 6293.3 11:04:24 INFO - PROCESS | 2000 | 11:04:24 INFO - PROCESS | 2000 | [#1] ext.html Cycles:180 Average:72930.39 Median:39813.10 stddev:163398.00 (410.4%) stddev-sans-first:163765.73 11:04:24 INFO - PROCESS | 2000 | Values: 440.8 482.3 486.7 490.4 536.5 36307.8 40301.2 40450.8 42789.6 42874.4 41695.1 42158.4 42213.2 42257.8 42277.5 8095.9 9226.8 9289.0 9411.9 9455.6 9452.5 9519.8 9522.3 9524.1 9567.2 9491.2 9523.9 9555.3 9571.3 9582.0 8556.7 9474.8 9493.5 9523.2 9544.0 9365.6 9446.8 9450.1 9468.0 9468.7 39468.4 39772.4 39810.2 39816.0 39852.8 3200.0 3325.9 3341.9 3363.9 3367.1 29280.0 29414.7 30196.2 30633.5 31440.2 3096.6 3177.2 3182.1 3186.0 3200.8 475757.0 477748.0 480188.0 481381.0 481611.0 62140.4 62465.0 62486.0 62559.4 62630.7 64064.7 64780.4 65054.7 65274.7 65465.0 16236.2 16262.4 16300.4 16511.3 16512.9 12568.1 12623.6 12643.4 12663.0 12754.4 18061.8 18612.4 18677.6 18722.9 18819.8 2771.8 3226.6 7591.8 7616.1 7919.0 854.5 937.2 1016.3 1077.9 1103.2 25908.7 30327.2 30361.4 30646.8 30988.0 947.4 1015.8 1023.2 1029.5 1073.2 14876.3 15050.3 15712.8 15888.1 16025.4 689306.0 691660.0 692066.0 694602.1 697820.0 47589.5 56866.7 57386.1 57480.7 57610.0 1353.4 1355.0 1381.0 1387.0 1388.2 29078.1 29811.7 29966.0 30135.8 30618.5 50134.0 50192.5 50581.0 50674.5 50675.2 633608.0 635446.0 636100.0 636222.0 641444.0 21417.0 26280.6 26490.5 26809.2 27163.2 45153.9 46900.8 47392.8 47503.8 47576.8 37369.3 38103.0 38909.0 40457.0 40648.8 37981.8 37982.6 38350.8 39123.0 39474.8 37268.6 38196.4 38245.8 38486.0 39692.0 26574.9 28081.9 32335.5 33460.7 34784.8 22975.2 25368.1 25897.5 26020.3 26021.3 11:04:24 INFO - PROCESS | 2000 | 11:04:24 INFO - PROCESS | 2000 | [#2] jquery.html Cycles:180 Average:32855.49 Median:11584.86 stddev:91997.11 (794.1%) stddev-sans-first:92222.87 11:04:24 INFO - PROCESS | 2000 | Values: 378.4 379.9 388.2 391.8 407.5 17713.4 19681.9 20128.8 20209.1 20284.8 15769.6 19299.8 19838.5 20102.0 20173.9 4826.3 5602.3 5896.0 5903.1 5909.2 5750.0 5909.9 5919.1 5922.7 5926.2 5552.3 5801.7 5838.9 5858.6 5862.5 5023.2 5760.9 5826.4 5840.4 5848.9 5069.6 5110.8 5365.0 5410.5 5462.0 12870.1 12954.2 13011.5 13102.9 13174.2 2104.6 2118.2 2159.8 2174.0 2223.3 8135.2 9783.6 10224.1 10251.2 12561.3 1740.0 1822.9 1828.7 1836.3 1895.7 104987.5 122555.0 126733.7 128221.0 129437.4 11388.9 11397.6 11658.3 11721.9 12130.3 14779.4 14794.3 14794.9 14796.2 14798.9 8210.9 8438.1 8467.6 8556.7 8565.8 8355.7 8361.5 8361.5 8488.8 8526.6 3839.8 4545.7 4559.2 4567.3 4658.9 1635.6 1957.4 1963.1 1977.4 2024.7 793.9 881.6 923.5 949.2 971.4 18678.2 20695.4 20866.5 20953.3 21051.5 879.4 885.0 897.6 944.5 1015.9 10346.6 10357.8 10382.6 10859.7 10978.3 484189.0 504094.6 523987.0 547659.4 661105.0 101130.0 101160.0 126447.4 136769.0 137694.0 935.6 998.5 1007.8 1009.4 1009.8 17952.3 18262.6 18603.8 18633.7 18977.6 51962.7 52193.0 52264.5 53673.7 54463.0 74143.0 75656.6 76460.0 77004.0 79022.2 6498.6 7757.4 7823.1 7921.5 8073.5 10149.8 12085.4 12089.8 12228.4 12466.9 10329.4 10408.0 10566.4 10604.7 10823.1 10463.6 10477.4 10694.8 10808.8 10936.9 10591.9 10678.5 10943.2 11017.0 11082.7 7865.9 7912.7 7913.7 8285.8 8293.2 8110.6 9731.7 10712.8 11087.6 11198.7 11:04:24 INFO - PROCESS | 2000 | 11:04:24 INFO - PROCESS | 2000 | [#3] mootools.html Cycles:180 Average:5424.85 Median:5165.82 stddev:2948.89 (57.1%) stddev-sans-first:2940.52 11:04:24 INFO - PROCESS | 2000 | Values: 1255.9 1432.4 1472.3 1598.3 1797.8 7505.5 7740.5 8025.8 8432.0 8472.9 7839.2 8131.9 8137.0 8229.8 8240.8 2302.3 2335.3 2335.4 2340.1 2341.3 2287.9 2312.1 2327.1 2332.6 2360.8 2293.0 2303.4 2313.0 2319.4 2319.7 2290.6 2302.6 2313.6 2324.5 2330.5 2330.9 2343.1 2348.4 2349.1 2355.0 8111.3 8174.1 8207.0 8272.4 8391.0 5009.4 5160.3 5171.4 5177.0 5190.7 3257.9 3399.2 3471.2 3564.6 3569.1 1016.9 1039.6 1078.2 1080.5 1105.7 9907.0 9997.3 10800.4 10848.2 10879.2 4440.0 4524.3 4674.7 4721.1 4745.5 9273.8 9371.2 9375.5 9376.3 9426.8 4260.3 5129.1 5145.6 5153.0 5158.2 3768.8 3909.2 4232.5 4342.7 4694.6 3769.4 3798.2 3861.2 3887.3 3893.3 1268.1 1278.0 1283.7 1289.9 1298.7 749.4 794.3 901.2 913.9 918.5 5054.5 5649.9 5675.9 5837.7 5845.5 902.0 902.4 961.4 970.5 987.9 3652.2 3877.0 3990.7 3994.7 4008.8 9604.6 10056.8 10078.2 10084.4 10095.2 9392.9 9923.2 9936.7 9973.4 10039.0 7565.3 7883.6 7890.6 7890.6 7925.1 5439.2 5568.9 5684.5 5741.3 5791.9 9162.7 9228.2 9235.4 9331.8 9422.3 9142.0 9450.0 9577.7 9598.8 9635.0 7126.0 7340.2 7537.4 7702.3 7877.8 7785.8 7979.8 7980.3 7983.6 7985.1 7043.5 7105.9 7145.8 7150.5 7227.0 6941.4 6948.7 6953.1 6969.1 7089.9 6558.1 6560.3 6601.9 6633.2 6661.6 4836.5 4838.8 4884.1 4903.4 4913.4 4837.6 4892.5 4902.4 4981.0 5003.8 11:04:24 INFO - PROCESS | 2000 | 11:04:24 INFO - PROCESS | 2000 | [#4] prototype.html Cycles:180 Average:4481.25 Median:4942.20 stddev:1427.42 (28.9%) stddev-sans-first:1396.53 11:04:24 INFO - PROCESS | 2000 | Values: 301.9 306.2 308.7 310.9 315.2 4811.7 5088.7 5237.6 5328.5 5368.8 4071.7 4616.7 5218.0 5266.3 5268.9 4007.0 4029.7 4041.8 4051.6 4062.5 3936.7 4036.8 4066.0 4086.4 4089.9 3818.0 3989.4 4026.5 4080.9 4096.7 3315.7 3779.6 3983.6 4026.6 4036.5 3538.1 3539.9 3546.9 3552.7 3586.6 4383.5 4411.9 4733.3 4873.3 5209.0 3516.5 3864.1 4526.4 4541.8 4642.6 5649.0 5652.7 5680.2 5693.2 5746.6 3325.9 3510.5 3690.3 3805.9 3829.3 4754.6 4857.4 5845.2 5852.9 5875.9 3139.9 3256.3 3305.6 3833.9 3869.9 3606.6 3929.4 3940.9 3941.5 3946.3 4254.0 4320.3 4498.7 4574.1 4602.7 4383.8 4693.7 5541.9 5648.9 5655.3 1194.8 1212.3 1235.8 1248.0 1275.5 786.8 838.3 851.2 861.7 882.3 4291.8 4912.6 5027.0 5062.9 5075.0 4669.9 5463.9 5475.6 5493.6 5516.6 4321.6 4489.8 4592.3 4662.3 5073.8 2546.7 2646.8 2875.7 2894.4 2916.3 5067.2 5266.9 5304.3 5673.7 5711.3 4866.5 5154.8 5303.5 5558.7 5628.2 5717.2 6032.4 6127.9 6134.8 6140.5 5006.8 5940.3 5995.6 5995.9 6006.7 5535.0 5836.0 5877.8 5890.9 5899.2 6151.0 6160.8 6199.8 6216.5 6221.8 3108.1 3392.0 3661.3 3677.9 3867.6 5282.6 5355.7 5454.6 5893.2 5951.6 4979.2 4996.7 5501.4 5563.2 5641.9 4394.5 5450.3 5678.5 5750.8 5826.6 4907.9 4971.8 5400.5 5612.3 5660.5 5672.5 5679.7 5790.8 5793.9 5817.2 5595.3 5614.3 5663.5 5718.3 5719.6 11:04:24 INFO - PROCESS | 2000 | 11:04:24 INFO - PROCESS | 2000 | [#5] yui.html Cycles:180 Average:18935.96 Median:26084.12 stddev:29007.76 (111.2%) stddev-sans-first:29056.77 11:04:24 INFO - PROCESS | 2000 | Values: 687.3 698.4 729.8 732.5 756.5 13750.7 14478.8 14695.5 14715.2 14741.8 13137.9 13221.7 13241.2 13267.6 13283.3 629.3 654.6 789.2 803.4 820.9 786.8 794.5 794.7 809.4 809.5 845.1 847.5 848.4 850.6 851.9 843.0 843.7 846.9 847.7 848.1 504.9 540.0 618.5 633.2 637.5 11158.7 11921.0 12832.3 13436.9 13564.5 12862.8 13140.4 13242.2 13334.3 13390.8 9227.4 10948.4 11343.9 11428.0 11820.1 3162.3 3594.5 3645.3 3698.0 3737.1 59291.0 63183.4 71278.3 90360.5 94120.0 10462.2 10765.0 10920.9 10949.9 11207.8 21297.3 21390.9 21457.4 21470.6 21488.9 7816.3 7979.1 7993.4 8003.4 8100.1 4205.1 4214.5 4265.0 4310.6 4386.6 3336.3 3430.1 3432.6 3438.8 3442.1 496.5 570.3 615.4 648.5 649.5 534.2 566.7 605.7 627.9 637.1 8579.9 8700.7 8778.3 8792.3 9145.5 606.5 609.6 611.9 616.6 638.6 4049.8 4095.3 4151.1 4216.3 4270.7 73957.9 118873.0 120503.4 122080.4 124670.0 102787.5 105207.0 106632.5 106645.9 106723.0 27352.5 27365.3 27484.9 62335.4 62621.7 8187.6 8190.0 8360.5 8450.5 8511.1 51634.0 57126.7 57925.0 59761.7 60149.7 67080.0 68321.3 72688.0 74161.3 79787.0 8316.8 9339.7 10639.0 10902.7 11307.1 11343.6 11786.9 11950.5 12022.3 12113.2 10414.7 10794.3 10906.2 10954.0 10974.5 9215.4 10941.3 11474.4 11671.4 11703.6 10242.6 10414.4 10955.9 11067.0 11103.2 9163.9 9383.1 9494.1 9701.6 9826.5 9459.4 9682.0 9687.8 9695.8 9710.9 11:04:24 INFO - PROCESS | 2000 | -------- Summary: end -------- 11:04:24 INFO - PROCESS | 2000 | 11:04:24 INFO - TEST-INFO | 2000: exit 0 11:04:24 INFO - TEST-OK | dromaeo_css | took 1116417ms 11:04:24 INFO - TEST-START | kraken 11:04:24 INFO - operating with platform_type : mac_ 11:04:24 INFO - Initialising browser for kraken test... 11:04:24 INFO - TEST-INFO | started process 2004 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmpdZaOhg/profile http://localhost:49401/getInfo.html) 11:04:26 ERROR - PROCESS | 2004 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 11:04:27 INFO - PROCESS | 2004 | __metrics Screen width/height:1600/1200 11:04:27 INFO - PROCESS | 2004 | colorDepth:24 11:04:27 INFO - PROCESS | 2004 | Browser inner width/height: 1024/689 11:04:27 INFO - PROCESS | 2004 | __metrics 11:04:27 ERROR - PROCESS | 2004 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 11:04:28 INFO - TEST-INFO | 2004: exit 0 11:04:28 INFO - Browser initialized. 11:04:28 INFO - Running cycle 1/1 for kraken test... 11:04:28 INFO - TEST-INFO | started process 2006 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmpdZaOhg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:04:40 INFO - PROCESS | 2006 | RSS: Main: 224243712 11:04:40 INFO - PROCESS | 2006 | 11:04:43 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49401/tests/kraken/driver.html?testName=audio-beat-detection) 11:04:44 INFO - PROCESS | 2006 | RSS: Main: 236519424 11:04:44 INFO - PROCESS | 2006 | 11:04:46 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49401/tests/kraken/driver.html?testName=audio-dft) 11:04:47 INFO - PROCESS | 2006 | RSS: Main: 244170752 11:04:47 INFO - PROCESS | 2006 | 11:04:50 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49401/tests/kraken/driver.html?testName=audio-fft) 11:04:51 INFO - PROCESS | 2006 | RSS: Main: 247762944 11:04:51 INFO - PROCESS | 2006 | 11:04:53 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49401/tests/kraken/driver.html?testName=audio-oscillator) 11:04:53 INFO - PROCESS | 2006 | RSS: Main: 249249792 11:04:53 INFO - PROCESS | 2006 | 11:04:55 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49401/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:04:56 INFO - PROCESS | 2006 | RSS: Main: 249196544 11:04:56 INFO - PROCESS | 2006 | 11:04:59 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49401/tests/kraken/driver.html?testName=imaging-darkroom) 11:04:59 INFO - PROCESS | 2006 | RSS: Main: 253300736 11:04:59 INFO - PROCESS | 2006 | 11:05:02 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49401/tests/kraken/driver.html?testName=imaging-desaturate) 11:05:03 INFO - PROCESS | 2006 | RSS: Main: 253558784 11:05:03 INFO - PROCESS | 2006 | 11:05:06 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49401/tests/kraken/driver.html?testName=json-parse-financial) 11:05:06 INFO - PROCESS | 2006 | RSS: Main: 253272064 11:05:06 INFO - PROCESS | 2006 | 11:05:08 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49401/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:05:09 INFO - PROCESS | 2006 | RSS: Main: 252612608 11:05:09 INFO - PROCESS | 2006 | 11:05:10 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49401/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:05:11 INFO - PROCESS | 2006 | RSS: Main: 252768256 11:05:11 INFO - PROCESS | 2006 | 11:05:13 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49401/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:05:14 INFO - PROCESS | 2006 | RSS: Main: 252174336 11:05:14 INFO - PROCESS | 2006 | 11:05:17 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49401/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:05:18 INFO - PROCESS | 2006 | RSS: Main: 252116992 11:05:18 INFO - PROCESS | 2006 | 11:05:21 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49401/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:05:22 INFO - PROCESS | 2006 | RSS: Main: 252436480 11:05:22 INFO - PROCESS | 2006 | 11:05:23 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49401/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49401/tests/kraken/driver.html?testName=ai-astar) 11:05:24 INFO - PROCESS | 2006 | RSS: Main: 254156800 11:05:24 INFO - PROCESS | 2006 | 11:05:24 INFO - PROCESS | 2006 | __start_tp_report 11:05:24 INFO - PROCESS | 2006 | _x_x_mozilla_page_load 11:05:24 INFO - PROCESS | 2006 | _x_x_mozilla_page_load_details 11:05:24 INFO - PROCESS | 2006 | |i|pagename|runs| 11:05:24 INFO - PROCESS | 2006 | |0;ai-astar;106;121;118;119;116;133;176;163;118;117 11:05:24 INFO - PROCESS | 2006 | |1;audio-beat-detection;138;130;142;177;141;102;143;147;179;117 11:05:24 INFO - PROCESS | 2006 | |2;audio-dft;202;196;196;196;195;194;193;195;196;198 11:05:24 INFO - PROCESS | 2006 | |3;audio-fft;77;59;60;87;59;83;85;60;78;59 11:05:24 INFO - PROCESS | 2006 | |4;audio-oscillator;91;72;91;72;69;70;86;70;71;119 11:05:24 INFO - PROCESS | 2006 | |5;imaging-gaussian-blur;128;96;89;87;90;85;90;88;88;86 11:05:24 INFO - PROCESS | 2006 | |6;imaging-darkroom;94;95;95;94;96;95;94;101;94;128 11:05:24 INFO - PROCESS | 2006 | |7;imaging-desaturate;89;92;90;138;114;90;87;90;97;89 11:05:24 INFO - PROCESS | 2006 | |8;json-parse-financial;55;58;56;57;60;58;60;60;59;60 11:05:24 INFO - PROCESS | 2006 | |9;json-stringify-tinderbox;60;86;90;64;70;65;64;63;74;62 11:05:24 INFO - PROCESS | 2006 | |10;stanford-crypto-aes;86;87;88;91;108;82;88;87;76;106 11:05:24 INFO - PROCESS | 2006 | |11;stanford-crypto-ccm;160;157;158;163;158;171;148;151;199;188 11:05:24 INFO - PROCESS | 2006 | |12;stanford-crypto-pbkdf2;170;177;170;168;183;227;212;169;168;169 11:05:24 INFO - PROCESS | 2006 | |13;stanford-crypto-sha256-iterative;67;76;78;84;75;68;68;69;67;66 11:05:24 INFO - PROCESS | 2006 | __end_tp_report 11:05:24 INFO - PROCESS | 2006 | __start_cc_report 11:05:24 INFO - PROCESS | 2006 | _x_x_mozilla_cycle_collect,986 11:05:24 INFO - PROCESS | 2006 | __end_cc_report 11:05:24 INFO - PROCESS | 2006 | __startTimestamp1479150324029__endTimestamp 11:05:24 INFO - PROCESS | 2006 | 11:05:24 INFO - PROCESS | 2006 | ------- Summary: start ------- 11:05:24 INFO - PROCESS | 2006 | Number of tests: 14 11:05:24 INFO - PROCESS | 2006 | 11:05:24 INFO - PROCESS | 2006 | [#0] ai-astar Cycles:10 Average:128.70 Median:120.00 stddev:22.68 (18.9%) stddev-sans-first:22.52 11:05:24 INFO - PROCESS | 2006 | Values: 106.0 121.0 118.0 119.0 116.0 133.0 176.0 163.0 118.0 117.0 11:05:24 INFO - PROCESS | 2006 | 11:05:24 INFO - PROCESS | 2006 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:142.50 stddev:23.58 (16.5%) stddev-sans-first:24.97 11:05:24 INFO - PROCESS | 2006 | Values: 138.0 130.0 142.0 177.0 141.0 102.0 143.0 147.0 179.0 117.0 11:05:24 INFO - PROCESS | 2006 | 11:05:24 INFO - PROCESS | 2006 | [#2] audio-dft Cycles:10 Average:196.10 Median:196.00 stddev:2.47 (1.3%) stddev-sans-first:1.42 11:05:24 INFO - PROCESS | 2006 | Values: 202.0 196.0 196.0 196.0 195.0 194.0 193.0 195.0 196.0 198.0 11:05:24 INFO - PROCESS | 2006 | 11:05:24 INFO - PROCESS | 2006 | [#3] audio-fft Cycles:10 Average:70.70 Median:77.50 stddev:12.27 (15.8%) stddev-sans-first:12.80 11:05:24 INFO - PROCESS | 2006 | Values: 77.0 59.0 60.0 87.0 59.0 83.0 85.0 60.0 78.0 59.0 11:05:24 INFO - PROCESS | 2006 | 11:05:24 INFO - PROCESS | 2006 | [#4] audio-oscillator Cycles:10 Average:81.10 Median:72.00 stddev:16.04 (22.3%) stddev-sans-first:16.61 11:05:24 INFO - PROCESS | 2006 | Values: 91.0 72.0 91.0 72.0 69.0 70.0 86.0 70.0 71.0 119.0 11:05:24 INFO - PROCESS | 2006 | 11:05:24 INFO - PROCESS | 2006 | [#5] imaging-gaussian-blur Cycles:10 Average:92.70 Median:88.50 stddev:12.76 (14.4%) stddev-sans-first:3.19 11:05:24 INFO - PROCESS | 2006 | Values: 128.0 96.0 89.0 87.0 90.0 85.0 90.0 88.0 88.0 86.0 11:05:24 INFO - PROCESS | 2006 | 11:05:24 INFO - PROCESS | 2006 | [#6] imaging-darkroom Cycles:10 Average:98.60 Median:94.50 stddev:10.54 (11.2%) stddev-sans-first:11.05 11:05:24 INFO - PROCESS | 2006 | Values: 94.0 95.0 95.0 94.0 96.0 95.0 94.0 101.0 94.0 128.0 11:05:24 INFO - PROCESS | 2006 | 11:05:24 INFO - PROCESS | 2006 | [#7] imaging-desaturate Cycles:10 Average:97.60 Median:90.00 stddev:16.22 (18.0%) stddev-sans-first:16.90 11:05:24 INFO - PROCESS | 2006 | Values: 89.0 92.0 90.0 138.0 114.0 90.0 87.0 90.0 97.0 89.0 11:05:24 INFO - PROCESS | 2006 | 11:05:24 INFO - PROCESS | 2006 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:59.50 stddev:1.83 (3.1%) stddev-sans-first:1.50 11:05:24 INFO - PROCESS | 2006 | Values: 55.0 58.0 56.0 57.0 60.0 58.0 60.0 60.0 59.0 60.0 11:05:24 INFO - PROCESS | 2006 | 11:05:24 INFO - PROCESS | 2006 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:67.50 stddev:10.44 (15.5%) stddev-sans-first:10.46 11:05:24 INFO - PROCESS | 2006 | Values: 60.0 86.0 90.0 64.0 70.0 65.0 64.0 63.0 74.0 62.0 11:05:24 INFO - PROCESS | 2006 | 11:05:24 INFO - PROCESS | 2006 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:87.00 stddev:9.90 (11.4%) stddev-sans-first:10.40 11:05:24 INFO - PROCESS | 2006 | Values: 86.0 87.0 88.0 91.0 108.0 82.0 88.0 87.0 76.0 106.0 11:05:24 INFO - PROCESS | 2006 | 11:05:24 INFO - PROCESS | 2006 | [#11] stanford-crypto-ccm Cycles:10 Average:165.30 Median:161.50 stddev:16.32 (10.1%) stddev-sans-first:17.19 11:05:24 INFO - PROCESS | 2006 | Values: 160.0 157.0 158.0 163.0 158.0 171.0 148.0 151.0 199.0 188.0 11:05:24 INFO - PROCESS | 2006 | 11:05:24 INFO - PROCESS | 2006 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.30 Median:173.50 stddev:20.99 (12.1%) stddev-sans-first:21.86 11:05:24 INFO - PROCESS | 2006 | Values: 170.0 177.0 170.0 168.0 183.0 227.0 212.0 169.0 168.0 169.0 11:05:24 INFO - PROCESS | 2006 | 11:05:24 INFO - PROCESS | 2006 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:72.00 stddev:6.07 (8.4%) stddev-sans-first:6.18 11:05:24 INFO - PROCESS | 2006 | Values: 67.0 76.0 78.0 84.0 75.0 68.0 68.0 69.0 67.0 66.0 11:05:24 INFO - PROCESS | 2006 | -------- Summary: end -------- 11:05:24 INFO - PROCESS | 2006 | 11:05:24 INFO - TEST-INFO | 2006: exit 0 11:05:24 INFO - TEST-OK | kraken | took 59994ms 11:05:24 INFO - SUITE-END | took 1176s 11:05:25 INFO - Completed test suite (00:19:36) 11:05:25 INFO - javascript benchmark 11:05:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7100.806970502506, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3330.2839889423776, 3363.9495407568907, 3410.0, 3456.706179974703, 3490.4240800267958, 5993.640381577108, 6024.246969128859, 6029.3970602939735, 6076.6050206736645, 6082.787102451415, 6028.577999540034, 6074.0, 6118.816435506931, 6132.202813634232, 6150.81547553573, 4484.686071974963, 5409.26974858393, 5484.204790305404, 5500.669959802404, 5559.527440167591, 5514.558835293167, 5527.447255274481, 5532.031894418481, 5533.667979921198, 5557.555395568365, 5368.489993450636, 5383.327084114486, 5515.062439385314, 5522.282103326562, 5526.751296191681, 5386.78452861885, 5417.6207665463435, 5444.128939369702, 5472.288602481692, 5521.033819081685, 4522.525134860858, 5355.6251062425645, 5508.504234618904, 5525.281713377275, 5559.444055594448, 6048.909266361008, 6118.724657390384, 6139.662318572477, 6172.321044685081, 6193.071039344134, 5173.3016042834115, 6144.293406258293, 6279.058141278799, 6294.898392781291, 6339.080833279195, 6292.5595208335435, 6302.96848515759, 6355.332690067523, 6441.742330306782, 6443.806685799434, 6175.59858609189, 6180.907286390753, 6181.041938499539, 6198.442140207403, 6198.6280823149855, 5678.3186017678145, 6301.77943771975, 6497.610143391412, 6509.121268628674, 6511.772087976898, 5861.325947516005, 6215.96892015537, 6219.40915613016, 6287.717052732638, 6333.841653958688, 6380.680965951684, 6392.264889537762, 6393.328700486475, 6395.392437718409, 6402.743890244338, 6168.519555306694, 6224.688765561704, 6278.0, 6289.0, 6314.179156709598, 5521.5306698931045, 6198.101275315054, 6215.627062376272, 6271.560990730605, 6276.874462510724, 4313.417688611998, 5027.321311622957, 5074.923876141861, 5095.439501654815, 5125.4874512549195, 4580.404547408815, 4582.770861456914, 4594.035252596926, 4594.540545945379, 4596.448426188812, 6021.2774467063355, 6034.275886893513, 6121.4490695837585, 6140.504248697391, 6185.474234690012, 6259.530535209787, 6282.780102696383, 6283.5287353448675, 6292.244930608264, 6297.4647154992335, 6058.091286307089, 6156.384361563897, 6166.784162554289, 6185.783497577563, 6190.442860142609, 5519.724013799294, 5530.419305972815, 5536.252605898233, 5562.22128901946, 5571.0, 6580.76967306142, 6597.208334999927, 6611.074449577063, 6612.338766123349, 6637.800865974028, 6214.098955651496, 6284.025975973731, 6397.0, 6413.8396540085005, 6427.55007149495, 5776.740046697824, 6478.2550006749825, 6510.576812507172, 6594.142761440982, 6603.108580341785, 6315.652639104894, 6336.841578960563, 6345.777897773556, 6348.650824204713, 6366.777162799465, 6195.349488303663, 6400.871982560416, 6420.486361091008, 6422.903656445251, 6426.100345951477, 6096.359882212481, 6159.6612186330185, 6184.6598437086395, 6188.81433556994, 6210.689465526615, 6231.065340198825, 6259.3427690091885, 6261.749530018748, 6284.402981716729, 6297.1813664223355, 6134.693265336626, 6236.6258024518675, 6250.062490626442, 6268.4671802897265, 6292.874142517216, 6168.722407491763, 6190.442860142609, 6202.224721909762, 6234.688265586793, 6251.718672659832, 6207.317195108625, 6253.937460625336, 6259.906101408574, 6270.686465676789, 6293.276273228455], "value": 5877.190632679309, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [440.7641911577307, 482.3271536206991, 486.734729572383, 490.409057086211, 536.4903341825266, 36307.81846090769, 40301.19397612046, 40450.7977460113, 42789.572104278945, 42874.35688464668, 41695.123719432624, 42158.367624485654, 42213.15573688532, 42257.78871105648, 42277.52028678989, 8095.919040809605, 9226.815463690738, 9288.953555232249, 9411.90588094117, 9455.574499147555, 9452.527373631325, 9519.80960380792, 9522.333436659437, 9524.095210954949, 9567.186789122932, 9491.19324857388, 9523.904760952371, 9555.331126821126, 9571.282153838456, 9581.952090239574, 8556.657733690645, 9474.763130921747, 9493.477858717768, 9523.238140948743, 9543.997880222616, 9365.625374984993, 9446.763830904214, 9450.149486546245, 9468.0, 9468.668596599086, 39468.407973880414, 39772.403413948814, 39810.20379592421, 39816.0, 39852.800735996425, 3199.9680003200137, 3325.93348133036, 3341.933161336784, 3363.915902102467, 3367.107716455141, 29280.0, 29414.70585294141, 30196.24509387261, 30633.540496892565, 31440.213994650087, 3096.551000104972, 3177.205698575356, 3182.140821978053, 3185.952210716841, 3200.8399580021137, 475757.0, 477748.0, 480188.0, 481380.9999999965, 481611.0, 62140.37859621346, 62465.0, 62486.0, 62559.37440625626, 62630.68684656639, 64064.67967660225, 64780.35219647743, 65054.674726626065, 65274.694506110565, 65465.01802472967, 16236.188190590423, 16262.430814921421, 16300.429484968206, 16511.256993435323, 16512.917435412746, 12568.120231583884, 12623.558175463999, 12643.43104560297, 12662.986961043094, 12754.426050827735, 18061.764104362093, 18612.44162675122, 18677.626447470975, 18722.906385467984, 18819.81180188208, 2771.7921155913386, 3226.6450690424035, 7591.848163036709, 7616.05790523413, 7918.960405197937, 854.4702284583474, 937.1612406895927, 1016.2632091733582, 1077.9191560632985, 1103.194667892443, 25908.74091259101, 30327.241818954702, 30361.392772144434, 30646.84676576603, 30988.0, 947.3889341374775, 1015.8425444056184, 1023.22746326523, 1029.4749677664295, 1073.1790180511914, 14876.330565124596, 15050.322735476711, 15712.764308535381, 15888.126153061692, 16025.358985640443, 689306.0, 691660.0, 692066.0, 694602.0539794639, 697820.0, 47589.5241047592, 56866.715666421405, 57386.13920791192, 57480.71259643675, 57610.0, 1353.3503918119359, 1354.9905320536263, 1381.0332767063096, 1387.036009973059, 1388.1532265318149, 29078.12765617035, 29811.70188298089, 29966.0, 30135.849320753256, 30618.540721888745, 50134.0, 50192.49807501878, 50581.0, 50674.49325506698, 50675.23987140269, 633608.0, 635446.0, 636100.0, 636222.0, 641444.0, 21417.0, 26280.60579091277, 26490.470190595694, 26809.19572412831, 27163.185104446897, 45153.87115322143, 46900.7654961723, 47392.763036184595, 47503.762481187376, 47576.810579735786, 37369.25261494809, 38103.0, 38909.0, 40457.0, 40648.79675601603, 37981.81009095047, 37982.62017379901, 38350.80824595859, 39123.0, 39474.80262598669, 37268.627313726516, 38196.42705359366, 38245.80877095597, 38486.037849053995, 39692.0, 26574.86712566425, 28081.859590701915, 32335.514967275038, 33460.66539334576, 34784.82607586946, 22975.195868144536, 25368.11211607585, 25897.482050359264, 26020.2760571239, 26021.349466262738], "value": 19742.988741672765, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.36812523086445, 379.91641838795465, 388.19255947628926, 391.8295541439476, 407.4723233412732, 17713.380031698893, 19681.901590492063, 20128.798712012875, 20209.090590923406, 20284.797152028474, 15769.60575985601, 19299.807001929978, 19838.50403739907, 20101.994900255002, 20173.899130504327, 4826.34844296019, 5602.327720673525, 5895.9705201473935, 5903.144044113601, 5909.172715819789, 5750.0, 5909.940900590982, 5919.1417244499735, 5922.674252916088, 5926.199963005004, 5552.305961754781, 5801.6519008859395, 5838.854028649275, 5858.5898987070705, 5862.530997520188, 5023.196288593807, 5760.884782304352, 5826.417358264182, 5840.386759390267, 5848.941510584925, 5069.569086627641, 5110.795568177268, 5365.0, 5410.5401040911565, 5462.0, 12870.099093063489, 12954.222746635232, 13011.479540818356, 13102.934485327607, 13174.209547427185, 2104.5580428110115, 2118.2374345235703, 2159.7732238115086, 2174.0, 2223.321886824518, 8135.186481351877, 9783.608655653765, 10224.079832815009, 10251.231157663131, 12561.309127997956, 1739.9826001739948, 1822.9426932379188, 1828.7074068149032, 1836.2563161919445, 1895.668258054835, 104987.47506262496, 122555.0, 126733.73266267404, 128221.0, 129437.35281323627, 11388.943055284837, 11397.601083962021, 11658.260308827419, 11721.941390292994, 12130.33283169434, 14779.408823646934, 14794.260286985607, 14794.852051479562, 14796.186209758567, 14798.926005369904, 8210.917890821134, 8438.113998030118, 8467.576621168917, 8556.74329770108, 8565.785855353666, 8355.749327520183, 8361.456505327134, 8361.498310101413, 8488.787780305418, 8526.57367131641, 3839.846406143779, 4545.704529205591, 4559.179347717442, 4567.287267274772, 4658.906821863544, 1635.64833560785, 1957.4323446200726, 1963.126408748122, 1977.4166620846884, 2024.6861736430876, 793.9007624046994, 881.6473410635668, 923.4690053219425, 949.1647350331664, 971.3637567393368, 18678.159482823306, 20695.379138625864, 20866.47833804167, 20953.26663566768, 21051.473713156985, 879.4459490521059, 884.9646014159362, 897.6095398501673, 944.4899754132691, 1015.939043657383, 10346.637867674595, 10357.792844143074, 10382.636607718694, 10859.728506787393, 10978.286411383395, 484189.0, 504094.60783333844, 523987.0, 547659.3851981786, 661105.0, 101130.0, 101160.0, 126447.3677631606, 136769.0, 137694.0, 935.5743136872707, 998.4758002048983, 1007.7833265847878, 1009.3641006166215, 1009.808136454086, 17952.281908724028, 18262.634747305245, 18603.813961860207, 18633.720494192326, 18977.620447591245, 51962.74018630034, 52193.0, 52264.466941632294, 53673.731631341594, 54463.0, 74143.0, 75656.62171689107, 76460.0, 77004.0, 79022.20977790149, 6498.642574658439, 7757.418193635613, 7823.100343460347, 7921.485103468256, 8073.515589064675, 10149.84775228387, 12085.395730213279, 12089.758204835678, 12228.449719762453, 12466.937665311616, 10329.431881246604, 10408.0, 10566.366018038942, 10604.734881628021, 10823.134149268197, 10463.581456741646, 10477.37135771856, 10694.786104277715, 10808.837867431837, 10936.945315273373, 10591.8940810594, 10678.46607669629, 10943.233973621771, 11017.0, 11082.667519974091, 7865.921340786519, 7912.683492660229, 7913.683452661829, 8285.83428331442, 8293.21214484623, 8110.594470276581, 9731.659391921248, 10712.839307410239, 11087.611933582286, 11198.720031999264], "value": 9169.593206331288, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1255.8618551959282, 1432.4485073246797, 1472.34480656108, 1598.3287019451836, 1797.829206225409, 7505.549667019969, 7740.458167928247, 8025.8394832103395, 8431.957840210798, 8472.91527084729, 7839.176886426914, 8131.878021829677, 8136.959315203416, 8229.83540329193, 8240.752777416687, 2302.297799171252, 2335.252719129879, 2335.392797872557, 2340.0756701103055, 2341.3327201747506, 2287.874166920819, 2312.0867257433306, 2327.0924339507606, 2332.5917964356254, 2360.8111351091957, 2293.0, 2303.435658263728, 2313.0, 2319.3621754017695, 2319.675245465636, 2290.5647926893835, 2302.574023805593, 2313.59260608541, 2324.500232450023, 2330.545543618995, 2330.8718020508863, 2343.121329501437, 2348.4011577047913, 2349.1425629645228, 2354.9991253717103, 8111.310538604226, 8174.100848906615, 8207.015158180997, 8272.3795715321, 8390.958045209796, 5009.373828271466, 5160.277561141444, 5171.3535808024, 5177.0, 5190.662606930575, 3257.8696852125886, 3399.167204035027, 3471.2189757304404, 3564.572251329857, 3569.1434055826676, 1016.8983101689846, 1039.563383378975, 1078.1751959750798, 1080.4543705428787, 1105.6959336182533, 9907.0, 9997.250206234488, 10800.351978881292, 10848.240623156382, 10879.184061195441, 4440.0, 4524.276115821453, 4674.719516829001, 4721.079389519079, 4745.549172828576, 9273.768155796024, 9371.156595906401, 9375.5312234388, 9376.343655944154, 9426.811463770686, 4260.25445547028, 5129.102407078746, 5145.588352931756, 5152.9742351288005, 5158.226266060121, 3768.7550309229814, 3909.237698648736, 4232.513260975027, 4342.739435633872, 4694.624430045588, 3769.4345848122452, 3798.2023775007556, 3861.1505468796818, 3887.3391523441082, 3893.3381325174787, 1268.0679700420185, 1277.9680507987375, 1283.7432513497151, 1289.9419526121346, 1298.6688394459352, 749.3855038868076, 794.2772077409529, 901.2159421303508, 913.8583519554479, 918.5499105438287, 5054.519820617035, 5649.858753531194, 5675.914861277084, 5837.737301821428, 5845.503132233723, 901.9954900225457, 902.4089221559889, 961.3895176562933, 970.5438443931341, 987.8863930647924, 3652.196516766307, 3876.980615096963, 3990.7206495545033, 3994.6804255659476, 4008.7795171265275, 9604.567794449267, 10056.798864022825, 10078.193744500422, 10084.445355505517, 10095.242856785624, 9392.90607093934, 9923.156531694742, 9936.701898943043, 9973.351732137387, 10038.996100389902, 7565.2812982766545, 7883.6058197089915, 7890.605469726605, 7890.644920978455, 7925.128235894047, 5439.156930675752, 5568.888622227614, 5684.516816070515, 5741.311042674739, 5791.855203619774, 9162.679306224516, 9228.169464748205, 9235.445873247627, 9331.813363732552, 9422.340436169676, 9142.0, 9450.0, 9577.664781732607, 9598.760030999281, 9635.0, 7126.0, 7340.192578816219, 7537.434692397982, 7702.345300649507, 7877.7636670899965, 7785.766427007199, 7979.84040319202, 7980.321672657889, 7983.640736166771, 7985.121636620083, 7043.542169758949, 7105.893411598727, 7145.785626431215, 7150.463715221484, 7226.963865180641, 6941.409980151744, 6948.6525673715105, 6953.061336719478, 6969.094017777859, 7089.858202836018, 6558.081868538504, 6560.3111673275525, 6601.900971485527, 6633.170853643294, 6661.566998145105, 4836.492168322417, 4838.806447742051, 4884.120858245407, 4903.41159060915, 4913.410390753133, 4837.588804951619, 4892.461829198856, 4902.411710594752, 4980.975095124646, 5003.849884503471], "value": 4407.431156292946, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.90791808498403, 306.1916540333518, 308.70364450127875, 310.94403007458646, 315.2497057004329, 4811.735354555498, 5088.669236499625, 5237.5548078413285, 5328.470799820151, 5368.792021795099, 4071.73533720308, 4616.722996620205, 5217.956408718262, 5266.3153790007345, 5268.868278293045, 4007.0, 4029.697772667047, 4041.8383264669524, 4051.5745846686114, 4062.512498500184, 3936.744111632749, 4036.757794532323, 4066.0, 4086.366613174948, 4089.8568550100754, 3817.980910095446, 3989.36170212766, 4026.5369482509595, 4080.9387859182134, 4096.651784598298, 3315.7347412207087, 3779.5653499847595, 3983.6016398359934, 4026.617471340218, 4036.4550785643855, 3538.1331573764337, 3539.893803185883, 3546.9113272168142, 3552.7335449841366, 3586.605473397924, 4383.517813040563, 4411.911761764747, 4733.254712266877, 4873.319674179187, 5209.0, 3516.4549494828343, 3864.091938394475, 4526.434195725535, 4541.772911354419, 4642.558956899089, 5649.022842005306, 5652.664927692681, 5680.204771332017, 5693.231413759131, 5746.626469279484, 3325.9168520786934, 3510.4558793387064, 3690.280395322913, 3805.9429108563395, 3829.2959632963343, 4754.643401744883, 4857.368542089541, 5845.223518828522, 5852.853678658025, 5875.882482350372, 3139.9058028259187, 3256.299895522474, 3305.636379998198, 3833.9041523962123, 3869.941950870683, 3606.6213047630145, 3929.4302326162547, 3940.862069827542, 3941.5270167580074, 3946.2699400610977, 4253.957460425356, 4320.308750599889, 4498.685092043525, 4574.056026188923, 4602.723836569817, 4383.802728877208, 4693.718376897397, 5541.861453463615, 5648.8870222595315, 5655.349634791969, 1194.8446701928694, 1212.278694176981, 1235.765204611121, 1247.9750404991848, 1275.5408053100875, 786.8001298020564, 838.3209600223838, 851.2253848997383, 861.7418568889492, 882.3338379523419, 4291.815479907065, 4912.557869791736, 5026.989204318302, 5062.873428164326, 5075.0, 4669.875206780906, 5463.945360546344, 5475.589330800206, 5493.587980901449, 5516.586256030814, 4321.6075380825905, 4489.820407183742, 4592.346755168137, 4662.300654901724, 5073.797048118034, 2546.668933038693, 2646.827956182842, 2875.7268059534313, 2894.435585060893, 2916.2709322669334, 5067.1639179535705, 5266.868328291824, 5304.336957880265, 5673.659580425106, 5711.259125272953, 4866.46468888422, 5154.768035438415, 5303.549198318109, 5558.6942718150085, 5628.185907046477, 5717.171010203498, 6032.366601506867, 6127.877442451037, 6134.8159555213415, 6140.478059364915, 5006.824761133488, 5940.277319577447, 5995.5803093783015, 5995.850103747442, 6006.699665016644, 5535.0, 5835.9708201458725, 5877.764889404547, 5890.852728681817, 5899.203607512931, 6150.969245153746, 6160.815175544741, 6199.845003874939, 6216.544464936415, 6221.844453888689, 3108.098651391071, 3391.9830400847836, 3661.2677464507738, 3677.8712745053795, 3867.593902640295, 5282.550983166474, 5355.705436201047, 5454.63629096729, 5893.233879595625, 5951.613145145551, 4979.228219625964, 4996.650234483696, 5501.3948465667945, 5563.248961390161, 5641.915371269352, 4394.538573449741, 5450.31871016123, 5678.517326027169, 5750.763585829067, 5826.552847803848, 4907.871189626335, 4971.837250795916, 5400.486953739389, 5612.298462692163, 5660.490555849993, 5672.468433522843, 5679.659220446786, 5790.826275211751, 5793.94206057934, 5817.185594016925, 5595.272614560244, 5614.326280846324, 5663.490285874291, 5718.313802343745, 5719.628224165416], "value": 4026.2079325943255, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.2852233676979, 698.3679769808324, 729.8467321862408, 732.4689600039972, 756.5044895593387, 13750.724985500285, 14478.782818257709, 14695.485658001986, 14715.190664513448, 14741.778873316895, 13137.868621313784, 13221.669458263548, 13241.205527668322, 13267.601971940858, 13283.269420181887, 629.2637613991641, 654.6301339743054, 789.2186735132207, 803.441608082383, 820.8522465956125, 786.8111653203247, 794.5431376958243, 794.6940427935258, 809.4050872608628, 809.5426084262402, 845.0746432656263, 847.478800537668, 848.3976376772468, 850.6172222499899, 851.8637018077109, 842.9968337678174, 843.6583183810536, 846.9407141500097, 847.6778824046853, 848.0967769325648, 504.93183420238165, 540.0360356763198, 618.4742968476804, 633.192679333853, 637.4613451633362, 11158.721031974184, 11920.986716129139, 12832.294223817686, 13436.865631343659, 13564.45742170312, 12862.812889637346, 13140.408681609351, 13242.205467671874, 13334.333283335794, 13390.799138012937, 9227.44635321883, 10948.3978381189, 11343.886561134366, 11428.028617567517, 11820.113491488088, 3162.304293055524, 3594.4788005739283, 3645.2527231917393, 3697.9630203698157, 3737.103095257146, 59291.0, 63183.36816631821, 71278.2872171282, 90360.5481972586, 94120.0, 10462.21533384984, 10765.0, 10920.945395273131, 10949.945250273857, 11207.831882521605, 21297.254596089064, 21390.893045534674, 21457.356279311647, 21470.604410713255, 21488.892555537434, 7816.335611472975, 7979.082405523439, 7993.400494962785, 8003.399745019147, 8100.079119829277, 4205.116925445691, 4214.494260688675, 4264.976405662619, 4310.590493903074, 4386.583274588909, 3336.299377130781, 3430.0567343980106, 3432.5880894292845, 3438.8452519636676, 3442.1050526863196, 496.53325873679347, 570.2672066394663, 615.3938370704852, 648.4812150279757, 649.4544582550585, 534.2467121358866, 566.7053132371226, 605.6564159565271, 627.8712863862897, 637.08260105448, 8579.871301930476, 8700.738977830675, 8778.253848422955, 8792.296616270683, 9145.496997665192, 606.548121649374, 609.5854818723222, 611.9051547010221, 616.605372561561, 638.635977492834, 4049.7772622505454, 4095.3242714952294, 4151.12826306473, 4216.262154123016, 4270.679699022524, 73957.89063164056, 118873.0, 120503.39748301203, 122080.38959805144, 124670.0, 102787.48606256921, 105207.0, 106632.46683766531, 106645.9335406636, 106723.0, 27352.452950941268, 27365.315867103483, 27484.862575687395, 62335.37664623386, 62621.68689156525, 8187.590620469072, 8189.959050204711, 8360.45657032291, 8450.45072070338, 8511.106333834858, 51634.0, 57126.7143664279, 57925.0, 59761.70119149376, 60149.699251503465, 67080.0, 68321.31678683149, 72688.0, 74161.25838741544, 79787.0, 8316.83366332682, 9339.719808405758, 10639.0, 10902.727431814268, 11307.095432365555, 11343.602973895873, 11786.882131178578, 11950.46222919988, 12022.27866328023, 12113.212641178296, 10414.73963150897, 10794.298370605886, 10906.182036347464, 10954.0, 10974.451277436256, 9215.44707317563, 10941.28881622692, 11474.368909710047, 11671.35807530594, 11703.590374336858, 10242.590296388062, 10414.375137491776, 10955.945220274167, 11067.00396964277, 11103.222774405715, 9163.908360916306, 9383.062170988762, 9494.145526902612, 9701.6119355225, 9826.5086745661, 9459.432434053979, 9681.957792529309, 9687.806243875224, 9695.806083878142, 9710.902890971], "value": 6788.676401121247, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 121.0, 118.0, 119.0, 116.0, 133.0, 176.0, 163.0, 118.0, 117.0], "value": 128.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 130.0, 142.0, 177.0, 141.0, 102.0, 143.0, 147.0, 179.0, 117.0], "value": 141.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 196.0, 196.0, 196.0, 195.0, 194.0, 193.0, 195.0, 196.0, 198.0], "value": 196.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 59.0, 60.0, 87.0, 59.0, 83.0, 85.0, 60.0, 78.0, 59.0], "value": 70.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 72.0, 91.0, 72.0, 69.0, 70.0, 86.0, 70.0, 71.0, 119.0], "value": 81.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 96.0, 89.0, 87.0, 90.0, 85.0, 90.0, 88.0, 88.0, 86.0], "value": 92.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 96.0, 95.0, 94.0, 101.0, 94.0, 128.0], "value": 98.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 90.0, 138.0, 114.0, 90.0, 87.0, 90.0, 97.0, 89.0], "value": 97.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 56.0, 57.0, 60.0, 58.0, 60.0, 60.0, 59.0, 60.0], "value": 58.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 86.0, 90.0, 64.0, 70.0, 65.0, 64.0, 63.0, 74.0, 62.0], "value": 69.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 88.0, 91.0, 108.0, 82.0, 88.0, 87.0, 76.0, 106.0], "value": 89.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 157.0, 158.0, 163.0, 158.0, 171.0, 148.0, 151.0, 199.0, 188.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 177.0, 170.0, 168.0, 183.0, 227.0, 212.0, 169.0, 168.0, 169.0], "value": 181.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 76.0, 78.0, 84.0, 75.0, 68.0, 68.0, 69.0, 67.0, 66.0], "value": 71.8, "unit": "score"}]}]} 11:05:25 INFO - Return code: 0 11:05:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:05:25 ERROR - # TBPL SUCCESS # 11:05:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:05:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:05:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:05:25 INFO - 2016-11-14 11:05:25.366 screenresolution[2012:13022] starting screenresolution argv=screenresolution get 11:05:25 INFO - 2016-11-14 11:05:25.368 screenresolution[2012:13022] Display 0: 1600x1200x32@60 11:05:25 INFO - 2016-11-14 11:05:25.374 screenresolution[2013:13025] starting screenresolution argv=screenresolution list 11:05:25 INFO - Available Modes on Display 0 11:05:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:05:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:05:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:05:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:05:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:05:25 INFO - Intel Iris: 11:05:25 INFO - Chipset Model: Intel Iris 11:05:25 INFO - Type: GPU 11:05:25 INFO - Bus: Built-In 11:05:25 INFO - VRAM (Dynamic, Max): 1536 MB 11:05:25 INFO - Vendor: Intel (0x8086) 11:05:25 INFO - Device ID: 0x0a2e 11:05:25 INFO - Revision ID: 0x0009 11:05:25 INFO - Displays: 11:05:25 INFO - Display: 11:05:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:05:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:05:25 INFO - Display Serial Number: 1600x1200 60 11:05:25 INFO - Main Display: Yes 11:05:25 INFO - Mirror: Off 11:05:25 INFO - Online: Yes 11:05:25 INFO - Rotation: Supported 11:05:25 INFO - Return code: 0 11:05:25 INFO - Running post-action listener: _resource_record_post_action 11:05:25 INFO - [mozharness: 2016-11-14 19:05:25.612904Z] Finished run-tests step (success) 11:05:25 INFO - Running post-run listener: _resource_record_post_run 11:05:25 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 700416; Write bytes: 651145728; Read time: 13; Write time: 2005 11:05:25 INFO - TinderboxPrint: CPU usage
54.3% 11:05:25 INFO - TinderboxPrint: I/O read bytes / time
700,416 / 13 11:05:25 INFO - TinderboxPrint: I/O write bytes / time
651,145,728 / 2,005 11:05:25 INFO - TinderboxPrint: CPU idle
2,212.0 (45.7%) 11:05:25 INFO - TinderboxPrint: CPU system
978.3 (20.2%) 11:05:25 INFO - TinderboxPrint: CPU user
1,647.3 (34.1%) 11:05:25 INFO - TinderboxPrint: Swap in / out
353,476,608 / 0 11:05:25 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 350331392; Write bytes: 346964992; Read time: 28287; Write time: 769 11:05:25 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 663552; Write bytes: 293015040; Read time: 12; Write time: 1200 11:05:26 INFO - Running post-run listener: _upload_blobber_files 11:05:26 INFO - Blob upload gear active. 11:05:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:05:26 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 11:05:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:05:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:05:26 INFO - (blobuploader) - INFO - Open directory for files ... 11:05:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:05:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:05:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:05:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:05:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:05:27 INFO - (blobuploader) - INFO - Done attempting. 11:05:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:05:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:05:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:05:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:05:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:05:29 INFO - (blobuploader) - INFO - Done attempting. 11:05:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:05:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:05:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:05:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:05:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:05:34 INFO - (blobuploader) - INFO - Done attempting. 11:05:34 INFO - (blobuploader) - INFO - Iteration through files over. 11:05:34 INFO - Return code: 0 11:05:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:05:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:05:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/06f51153607e566edc8689577dec1050861093e0358ebaa065b60422b2a459c57701964c531d2921c1f3ddfe6fa7df77c29701de2992572499d411d10580ab8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d0de381b8065203ac33859a3a37042e28c2f89e41332dc14b364fb6211e0d82d980da1efae8bc53741c8ce14f6d6b0e085f0ce2af7bc37e1434b8d58defffe8e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73b79e868bed02d45e6bb4b1f3da51077256500c7d31518bb43d8d195cc11e56a3c1f52486dd1a0d6e0f8dc4564e6aa2743fd61927e4e56122d3241ba4359368"} 11:05:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:05:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:05:34 INFO - Contents: 11:05:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/06f51153607e566edc8689577dec1050861093e0358ebaa065b60422b2a459c57701964c531d2921c1f3ddfe6fa7df77c29701de2992572499d411d10580ab8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d0de381b8065203ac33859a3a37042e28c2f89e41332dc14b364fb6211e0d82d980da1efae8bc53741c8ce14f6d6b0e085f0ce2af7bc37e1434b8d58defffe8e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73b79e868bed02d45e6bb4b1f3da51077256500c7d31518bb43d8d195cc11e56a3c1f52486dd1a0d6e0f8dc4564e6aa2743fd61927e4e56122d3241ba4359368"} 11:05:34 INFO - Running post-run listener: copy_logs_to_upload_dir 11:05:34 INFO - Copying logs to upload dir... 11:05:34 INFO - mkdir: /builds/slave/test/build/upload/logs 11:05:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.598030 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-11-14 11:05:34.499435) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 11:05:34.503400) ========= 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.VjQh7eVbzu/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.6X3MyeUUqa/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/06f51153607e566edc8689577dec1050861093e0358ebaa065b60422b2a459c57701964c531d2921c1f3ddfe6fa7df77c29701de2992572499d411d10580ab8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d0de381b8065203ac33859a3a37042e28c2f89e41332dc14b364fb6211e0d82d980da1efae8bc53741c8ce14f6d6b0e085f0ce2af7bc37e1434b8d58defffe8e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73b79e868bed02d45e6bb4b1f3da51077256500c7d31518bb43d8d195cc11e56a3c1f52486dd1a0d6e0f8dc4564e6aa2743fd61927e4e56122d3241ba4359368"} build_url:https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011142 build_url: 'https://queue.taskcluster.net/v1/task/QQZLLuCyTS2ZaGKUzfI74g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/06f51153607e566edc8689577dec1050861093e0358ebaa065b60422b2a459c57701964c531d2921c1f3ddfe6fa7df77c29701de2992572499d411d10580ab8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d0de381b8065203ac33859a3a37042e28c2f89e41332dc14b364fb6211e0d82d980da1efae8bc53741c8ce14f6d6b0e085f0ce2af7bc37e1434b8d58defffe8e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73b79e868bed02d45e6bb4b1f3da51077256500c7d31518bb43d8d195cc11e56a3c1f52486dd1a0d6e0f8dc4564e6aa2743fd61927e4e56122d3241ba4359368"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 11:05:34.536378) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:05:34.536708) ========= 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.VjQh7eVbzu/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.6X3MyeUUqa/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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.005074 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:05:34.585791) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 11:05:34.586184) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 11:05:34.586516) ========= ========= Total master_lag: 0.18 =========