builder: larch_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0090 starttime: 1478390651.94 results: success (0) buildid: 20161105145229 builduid: 3459783b24ce41e88743432cdb33cedb revision: 7ccf894aacb0840b8e06e028abe1d494c5c001c5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-05 17:04:11.940142) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-05 17:04:11.940617) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-05 17:04:11.940917) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-05 17:04:11.978958) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 17:04:11.979223) ========= 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.Esp7xnFhCd/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.AecIwXk4i5/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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-05 17:04:11-- 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% 10.1M=0.001s 2016-11-05 17:04:12 (10.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122441 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 17:04:12.196198) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 17:04:12.196512) ========= 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.Esp7xnFhCd/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.AecIwXk4i5/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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.031891 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 17:04:12.249756) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 17:04:12.250152) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 7ccf894aacb0840b8e06e028abe1d494c5c001c5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 7ccf894aacb0840b8e06e028abe1d494c5c001c5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Esp7xnFhCd/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.AecIwXk4i5/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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-05 17:04:12,328 truncating revision to first 12 chars 2016-11-05 17:04:12,328 Setting DEBUG logging. 2016-11-05 17:04:12,328 attempt 1/10 2016-11-05 17:04:12,328 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/7ccf894aacb0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-05 17:04:13,016 unpacking tar archive at: larch-7ccf894aacb0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.941940 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 17:04:13.214430) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-05 17:04:13.214792) ========= script_repo_revision: 7ccf894aacb0840b8e06e028abe1d494c5c001c5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-05 17:04:13.215197) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-05 17:04:13.215471) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-05 17:04:13.233934) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-11-05 17:04:13.234265) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Larch', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Esp7xnFhCd/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.AecIwXk4i5/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 17:04:13 INFO - MultiFileLogger online at 20161105 17:04:13 in /builds/slave/test 17:04:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 17:04:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:04:13 INFO - {'append_to_log': False, 17:04:13 INFO - 'base_work_dir': '/builds/slave/test', 17:04:13 INFO - 'blob_upload_branch': 'Larch', 17:04:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:04:13 INFO - 'branch': 'Larch', 17:04:13 INFO - 'buildbot_json_path': 'buildprops.json', 17:04:13 INFO - 'config_files': ('talos/mac_config.py',), 17:04:13 INFO - 'default_actions': ('clobber', 17:04:13 INFO - 'read-buildbot-config', 17:04:13 INFO - 'download-and-extract', 17:04:13 INFO - 'populate-webroot', 17:04:13 INFO - 'create-virtualenv', 17:04:13 INFO - 'install', 17:04:13 INFO - 'run-tests'), 17:04:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:04:13 INFO - 'download_minidump_stackwalk': True, 17:04:13 INFO - 'download_symbols': 'ondemand', 17:04:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:04:13 INFO - 'tooltool.py': '/tools/tooltool.py', 17:04:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:04:13 INFO - '/tools/misc-python/virtualenv.py')}, 17:04:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:04:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:04:13 INFO - 'installer_path': 'installer.exe', 17:04:13 INFO - 'log_level': 'info', 17:04:13 INFO - 'log_name': 'talos', 17:04:13 INFO - 'log_to_console': True, 17:04:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:04:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:04:13 INFO - 'opt_config_files': (), 17:04:13 INFO - 'pip_index': False, 17:04:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:04:13 INFO - 'cmd': ('bash', 17:04:13 INFO - '-c', 17:04:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:04:13 INFO - 'enabled': True, 17:04:13 INFO - 'halt_on_failure': False, 17:04:13 INFO - 'name': 'check_screen_resolution'},), 17:04:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:04:13 INFO - 'cmd': ('bash', 17:04:13 INFO - '-c', 17:04:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:04:13 INFO - 'enabled': True, 17:04:13 INFO - 'halt_on_failure': False, 17:04:13 INFO - 'name': 'check_screen_resolution'},), 17:04:13 INFO - 'run_cmd_checks_enabled': True, 17:04:13 INFO - 'sps_profile': False, 17:04:13 INFO - 'sps_profile_interval': 0, 17:04:13 INFO - 'suite': 'dromaeojs', 17:04:13 INFO - 'system_bits': '32', 17:04:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:04:13 INFO - 'title': 't-yosemite-r7-0090', 17:04:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:04:13 INFO - 'use_talos_json': True, 17:04:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:04:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:04:13 INFO - 'work_dir': 'build'} 17:04:13 INFO - [mozharness: 2016-11-06 00:04:13.444361Z] Running clobber step. 17:04:13 INFO - Running pre-action listener: _resource_record_pre_action 17:04:13 INFO - Running main action method: clobber 17:04:13 INFO - rmtree: /builds/slave/test/build 17:04:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:04:15 INFO - Running post-action listener: _resource_record_post_action 17:04:15 INFO - [mozharness: 2016-11-06 00:04:15.844159Z] Finished clobber step (success) 17:04:15 INFO - [mozharness: 2016-11-06 00:04:15.844279Z] Running read-buildbot-config step. 17:04:15 INFO - Running pre-action listener: _resource_record_pre_action 17:04:15 INFO - Running main action method: read_buildbot_config 17:04:15 INFO - Using buildbot properties: 17:04:15 INFO - { 17:04:15 INFO - "project": "", 17:04:15 INFO - "product": "firefox", 17:04:15 INFO - "script_repo_revision": "production", 17:04:15 INFO - "builddir": "larch_yosemite_r7_test-dromaeojs", 17:04:15 INFO - "repository": "", 17:04:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 larch talos dromaeojs", 17:04:15 INFO - "buildid": "20161105145229", 17:04:15 INFO - "pgo_build": "False", 17:04:15 INFO - "basedir": "/builds/slave/test", 17:04:15 INFO - "buildnumber": 0, 17:04:15 INFO - "slavename": "t-yosemite-r7-0090", 17:04:15 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 17:04:15 INFO - "platform": "yosemite_r7", 17:04:15 INFO - "scheduler": "tests-larch-macosx64-talos", 17:04:15 INFO - "branch": "larch", 17:04:15 INFO - "repo_path": "projects/larch", 17:04:15 INFO - "revision": "7ccf894aacb0840b8e06e028abe1d494c5c001c5", 17:04:15 INFO - "stage_platform": "macosx64", 17:04:15 INFO - "builduid": "3459783b24ce41e88743432cdb33cedb", 17:04:15 INFO - "slavebuilddir": "test" 17:04:15 INFO - } 17:04:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/TjvhzVnfQuqS64A_Z0tXhA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 17:04:15 INFO - Running post-action listener: _resource_record_post_action 17:04:15 INFO - [mozharness: 2016-11-06 00:04:15.848498Z] Finished read-buildbot-config step (success) 17:04:15 INFO - [mozharness: 2016-11-06 00:04:15.848628Z] Running download-and-extract step. 17:04:15 INFO - Running pre-action listener: _resource_record_pre_action 17:04:15 INFO - Running main action method: download_and_extract 17:04:15 INFO - mkdir: /builds/slave/test/build/tests 17:04: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')]} 17:04:15 INFO - trying https://queue.taskcluster.net/v1/task/TjvhzVnfQuqS64A_Z0tXhA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 17:04:15 INFO - Downloading https://queue.taskcluster.net/v1/task/TjvhzVnfQuqS64A_Z0tXhA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 17:04:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TjvhzVnfQuqS64A_Z0tXhA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 17:04:17 INFO - Downloaded 1199 bytes. 17:04:17 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 17:04:17 INFO - Using the following test package requirements: 17:04:17 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 17:04:17 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:04:17 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 17:04:17 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:04:17 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 17:04:17 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:04:17 INFO - u'jsshell-mac.zip'], 17:04:17 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:04:17 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 17:04:17 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 17:04:17 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:04:17 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 17:04:17 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:04:17 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 17:04:17 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:04:17 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 17:04:17 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 17:04:17 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 17:04:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:04:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TjvhzVnfQuqS64A_Z0tXhA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 17:04:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TjvhzVnfQuqS64A_Z0tXhA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:04:17 INFO - Fetch https://queue.taskcluster.net/v1/task/TjvhzVnfQuqS64A_Z0tXhA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 17:04:17 INFO - Http code: 200 17:04:17 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 17:04:17 INFO - x-amz-cf-id: VqBSwOgBQ17EXosvU4nOmgbECUa25FBx7fTpTIMdSZdzTnH4Ii1PwA== 17:04:17 INFO - x-amz-version-id: GSoy3HKxvW9LQ.ObES3qTtURxxHgVb97 17:04:18 INFO - Expected file size: 16308100 17:04:18 INFO - Obtained file size: 16308100 17:04:25 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:04:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TjvhzVnfQuqS64A_Z0tXhA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 17:04:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TjvhzVnfQuqS64A_Z0tXhA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:04:25 INFO - Fetch https://queue.taskcluster.net/v1/task/TjvhzVnfQuqS64A_Z0tXhA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 17:04:25 INFO - Http code: 200 17:04:25 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 17:04:25 INFO - x-amz-cf-id: BkeK94RGE96rfk6bbPAr7M_rxTAi4AKjvOKZxlLRIJsMpSLDihXf7w== 17:04:25 INFO - x-amz-version-id: GSoy3HKxvW9LQ.ObES3qTtURxxHgVb97 17:04:26 INFO - Expected file size: 16308100 17:04:26 INFO - Obtained file size: 16308100 17:04:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TjvhzVnfQuqS64A_Z0tXhA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 17:04:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TjvhzVnfQuqS64A_Z0tXhA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:04:32 INFO - Fetch https://queue.taskcluster.net/v1/task/TjvhzVnfQuqS64A_Z0tXhA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 17:04:33 INFO - Http code: 200 17:04:33 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 17:04:33 INFO - x-amz-cf-id: tZ0h0dX-OsxP0PYNxrK26odSCVxhLyAqMIRqKn85B9jrk76NS7xgNw== 17:04:33 INFO - x-amz-version-id: V0ltJdRTbLPBlO0jdViOEtTTQSja7ma2 17:04:33 INFO - Expected file size: 14409038 17:04:33 INFO - Obtained file size: 14409038 17:04:33 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')]} 17:04:33 INFO - trying https://queue.taskcluster.net/v1/task/TjvhzVnfQuqS64A_Z0tXhA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 17:04:33 INFO - Downloading https://queue.taskcluster.net/v1/task/TjvhzVnfQuqS64A_Z0tXhA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 17:04:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TjvhzVnfQuqS64A_Z0tXhA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 17:04:36 INFO - Downloaded 111582065 bytes. 17:04:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TjvhzVnfQuqS64A_Z0tXhA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 17:04:36 INFO - mkdir: /builds/slave/test/properties 17:04:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:04:36 INFO - Writing to file /builds/slave/test/properties/build_url 17:04:36 INFO - Contents: 17:04:36 INFO - build_url:https://queue.taskcluster.net/v1/task/TjvhzVnfQuqS64A_Z0tXhA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 17:04:37 INFO - Running post-action listener: _resource_record_post_action 17:04:37 INFO - Running post-action listener: set_extra_try_arguments 17:04:37 INFO - [mozharness: 2016-11-06 00:04:37.534247Z] Finished download-and-extract step (success) 17:04:37 INFO - [mozharness: 2016-11-06 00:04:37.534366Z] Running populate-webroot step. 17:04:37 INFO - Running pre-action listener: _resource_record_pre_action 17:04:37 INFO - Running main action method: populate_webroot 17:04:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:04:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:04:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:04:37 INFO - '--tppagecycles', 17:04:37 INFO - '7'], 17:04:37 INFO - 'tests': ['tsvgm']}}, 17:04:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:04:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:04:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:04:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:04:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:04:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:04:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:37 INFO - 'talos_options': ['--disable-e10s'], 17:04:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:04:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:04:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:37 INFO - 'talos_options': ['--disable-e10s'], 17:04:37 INFO - 'tests': ['damp', 'tps']}, 17:04:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:37 INFO - 'tests': ['damp', 'tps']}, 17:04:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:04:37 INFO - 'tests': ['dromaeo_dom']}, 17:04:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:04:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:04:37 INFO - 'tests': ['basic_compositor_video']}, 17:04:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:04:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:04:37 INFO - 'tests': ['a11yr', 17:04:37 INFO - 'ts_paint', 17:04:37 INFO - 'tpaint', 17:04:37 INFO - 'sessionrestore', 17:04:37 INFO - 'sessionrestore_no_auto_restore', 17:04:37 INFO - 'tabpaint']}, 17:04:37 INFO - 'other-e10s': {'tests': ['a11yr', 17:04:37 INFO - 'ts_paint', 17:04:37 INFO - 'tpaint', 17:04:37 INFO - 'sessionrestore', 17:04:37 INFO - 'sessionrestore_no_auto_restore', 17:04:37 INFO - 'tabpaint']}, 17:04:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:04:37 INFO - 'ts_paint', 17:04:37 INFO - 'tpaint', 17:04:37 INFO - 'sessionrestore', 17:04:37 INFO - 'sessionrestore_no_auto_restore', 17:04:37 INFO - 'tabpaint']}, 17:04:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:04:37 INFO - 'ts_paint', 17:04:37 INFO - 'tpaint', 17:04:37 INFO - 'sessionrestore', 17:04:37 INFO - 'sessionrestore_no_auto_restore', 17:04:37 INFO - 'tabpaint']}, 17:04:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:04:37 INFO - 'tests': ['a11yr', 17:04:37 INFO - 'ts_paint', 17:04:37 INFO - 'tpaint', 17:04:37 INFO - 'sessionrestore', 17:04:37 INFO - 'sessionrestore_no_auto_restore', 17:04:37 INFO - 'tabpaint']}, 17:04:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:04:37 INFO - 'tests': ['a11yr', 17:04:37 INFO - 'ts_paint', 17:04:37 INFO - 'tpaint', 17:04:37 INFO - 'sessionrestore', 17:04:37 INFO - 'sessionrestore_no_auto_restore', 17:04:37 INFO - 'tabpaint']}, 17:04:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:04:37 INFO - 'tests': ['tsvgx', 17:04:37 INFO - 'tsvgr_opacity', 17:04:37 INFO - 'tart', 17:04:37 INFO - 'tscrollx', 17:04:37 INFO - 'cart']}, 17:04:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:04:37 INFO - 'tsvgr_opacity', 17:04:37 INFO - 'tart', 17:04:37 INFO - 'tscrollx', 17:04:37 INFO - 'cart']}, 17:04:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:37 INFO - 'talos_options': ['--disable-e10s'], 17:04:37 INFO - 'tests': ['tp5o']}, 17:04:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:37 INFO - 'tests': ['tp5o']}, 17:04:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:37 INFO - 'talos_options': ['--disable-e10s', 17:04:37 INFO - '--xperf_path', 17:04:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:04:37 INFO - 'tests': ['tp5n']}, 17:04:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:37 INFO - 'talos_options': ['--xperf_path', 17:04:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:04:37 INFO - 'tests': ['tp5n']}}, 17:04:37 INFO - 'talos.zip': {'path': '', 17:04:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:04:37 INFO - Running post-action listener: _resource_record_post_action 17:04:37 INFO - [mozharness: 2016-11-06 00:04:37.553634Z] Finished populate-webroot step (success) 17:04:37 INFO - [mozharness: 2016-11-06 00:04:37.553746Z] Running create-virtualenv step. 17:04:37 INFO - Running pre-action listener: _resource_record_pre_action 17:04:37 INFO - Running main action method: create_virtualenv 17:04:37 INFO - Creating virtualenv /builds/slave/test/build/venv 17:04:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:04:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:04:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:04:37 INFO - Using real prefix '/tools/python27' 17:04:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:04:38 INFO - Installing distribute.............................................................................................................................................................................................done. 17:04:41 INFO - Installing pip.................done. 17:04:41 INFO - Return code: 0 17:04:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:04:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:04:41 INFO - Reading from file tmpfile_stdout 17:04:41 INFO - Output received: 17:04:41 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 17:04:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:04:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:04:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba43490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9b9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6c2caf470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b857d30>, '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 0x10b67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b84fb20>, '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.Esp7xnFhCd/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.AecIwXk4i5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 17:04:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:04:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:04:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Esp7xnFhCd/Render', 17:04:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:04:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:04:41 INFO - 'HOME': '/Users/cltbld', 17:04:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:04:41 INFO - 'LOGNAME': 'cltbld', 17:04:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:41 INFO - 'MOZ_NO_REMOTE': '1', 17:04:41 INFO - 'NO_EM_RESTART': '1', 17:04:41 INFO - 'PAGER': '/bin/cat', 17:04:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:04:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:41 INFO - 'PWD': '/builds/slave/test', 17:04:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:04:41 INFO - 'SHELL': '/bin/bash', 17:04:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AecIwXk4i5/Listeners', 17:04:41 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 17:04:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:04:41 INFO - 'USER': 'cltbld', 17:04:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:04:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:04:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:41 INFO - 'XPC_FLAGS': '0x0', 17:04:41 INFO - 'XPC_SERVICE_NAME': '0', 17:04:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:04:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:41 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 17:04:41 INFO - Cleaning up... 17:04:41 INFO - Return code: 0 17:04:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:04:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:04:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ba43490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9b9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6c2caf470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b857d30>, '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 0x10b67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b84fb20>, '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.Esp7xnFhCd/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.AecIwXk4i5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 17:04:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:04:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:04:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Esp7xnFhCd/Render', 17:04:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:04:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:04:41 INFO - 'HOME': '/Users/cltbld', 17:04:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:04:41 INFO - 'LOGNAME': 'cltbld', 17:04:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:41 INFO - 'MOZ_NO_REMOTE': '1', 17:04:41 INFO - 'NO_EM_RESTART': '1', 17:04:41 INFO - 'PAGER': '/bin/cat', 17:04:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:04:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:41 INFO - 'PWD': '/builds/slave/test', 17:04:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:04:41 INFO - 'SHELL': '/bin/bash', 17:04:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AecIwXk4i5/Listeners', 17:04:41 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 17:04:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:04:41 INFO - 'USER': 'cltbld', 17:04:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:04:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:04:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:41 INFO - 'XPC_FLAGS': '0x0', 17:04:41 INFO - 'XPC_SERVICE_NAME': '0', 17:04:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:04:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:42 INFO - Downloading/unpacking psutil>=3.1.1 17:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:04:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:04:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:04:45 INFO - Installing collected packages: psutil 17:04:45 INFO - Running setup.py install for psutil 17:04:45 INFO - building 'psutil._psutil_osx' extension 17:04:45 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 17:04:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 17:04:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 17:04:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 17:04:46 INFO - building 'psutil._psutil_posix' extension 17:04:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 17:04:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:04:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:04:46 INFO - ^ 17:04:46 INFO - 1 warning generated. 17:04:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 17:04:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:04:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:04:47 INFO - Successfully installed psutil 17:04:47 INFO - Cleaning up... 17:04:47 INFO - Return code: 0 17:04:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:04:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:04:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:47 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 0x10ba43490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9b9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6c2caf470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b857d30>, '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 0x10b67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b84fb20>, '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.Esp7xnFhCd/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.AecIwXk4i5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 17:04:47 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 17:04:47 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 17:04:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Esp7xnFhCd/Render', 17:04:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:04:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:04:47 INFO - 'HOME': '/Users/cltbld', 17:04:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:04:47 INFO - 'LOGNAME': 'cltbld', 17:04:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:47 INFO - 'MOZ_NO_REMOTE': '1', 17:04:47 INFO - 'NO_EM_RESTART': '1', 17:04:47 INFO - 'PAGER': '/bin/cat', 17:04:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:04:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:47 INFO - 'PWD': '/builds/slave/test', 17:04:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:04:47 INFO - 'SHELL': '/bin/bash', 17:04:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AecIwXk4i5/Listeners', 17:04:47 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 17:04:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:04:47 INFO - 'USER': 'cltbld', 17:04:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:04:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:04:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:47 INFO - 'XPC_FLAGS': '0x0', 17:04:47 INFO - 'XPC_SERVICE_NAME': '0', 17:04:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:04:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:04:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:04:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:04:49 INFO - Installing collected packages: mozsystemmonitor 17:04:49 INFO - Running setup.py install for mozsystemmonitor 17:04:50 INFO - Successfully installed mozsystemmonitor 17:04:50 INFO - Cleaning up... 17:04:50 INFO - Return code: 0 17:04:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:04:50 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')]} 17:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:50 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')]} 17:04:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:50 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 0x10ba43490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9b9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6c2caf470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b857d30>, '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 0x10b67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b84fb20>, '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.Esp7xnFhCd/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.AecIwXk4i5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 17:04:50 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 17:04:50 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 17:04:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Esp7xnFhCd/Render', 17:04:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:04:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:04:50 INFO - 'HOME': '/Users/cltbld', 17:04:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:04:50 INFO - 'LOGNAME': 'cltbld', 17:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:50 INFO - 'MOZ_NO_REMOTE': '1', 17:04:50 INFO - 'NO_EM_RESTART': '1', 17:04:50 INFO - 'PAGER': '/bin/cat', 17:04:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:50 INFO - 'PWD': '/builds/slave/test', 17:04:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:04:50 INFO - 'SHELL': '/bin/bash', 17:04:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AecIwXk4i5/Listeners', 17:04:50 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 17:04:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:04:50 INFO - 'USER': 'cltbld', 17:04:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:04:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:50 INFO - 'XPC_FLAGS': '0x0', 17:04:50 INFO - 'XPC_SERVICE_NAME': '0', 17:04:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:04:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:50 INFO - Downloading/unpacking jsonschema==2.5.1 17:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:04:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04:53 INFO - Downloading functools32-3.2.3-2.tar.gz 17:04:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:04:53 INFO - warning: no files found matching '*.txt' 17:04:53 INFO - no previously-included directories found matching 'build' 17:04:53 INFO - no previously-included directories found matching 'dist' 17:04:53 INFO - no previously-included directories found matching '.git*' 17:04:53 INFO - Installing collected packages: jsonschema, functools32 17:04:53 INFO - Running setup.py install for functools32 17:04:53 INFO - warning: no files found matching '*.txt' 17:04:53 INFO - no previously-included directories found matching 'build' 17:04:53 INFO - no previously-included directories found matching 'dist' 17:04:53 INFO - no previously-included directories found matching '.git*' 17:04:53 INFO - Successfully installed jsonschema functools32 17:04:53 INFO - Cleaning up... 17:04:54 INFO - Return code: 0 17:04:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:04:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:54 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 0x10ba43490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9b9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6c2caf470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b857d30>, '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 0x10b67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b84fb20>, '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.Esp7xnFhCd/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.AecIwXk4i5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 17:04:54 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 17:04:54 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 17:04:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Esp7xnFhCd/Render', 17:04:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:04:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:04:54 INFO - 'HOME': '/Users/cltbld', 17:04:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:04:54 INFO - 'LOGNAME': 'cltbld', 17:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:54 INFO - 'MOZ_NO_REMOTE': '1', 17:04:54 INFO - 'NO_EM_RESTART': '1', 17:04:54 INFO - 'PAGER': '/bin/cat', 17:04:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:54 INFO - 'PWD': '/builds/slave/test', 17:04:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:04:54 INFO - 'SHELL': '/bin/bash', 17:04:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AecIwXk4i5/Listeners', 17:04:54 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 17:04:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:04:54 INFO - 'USER': 'cltbld', 17:04:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:04:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:54 INFO - 'XPC_FLAGS': '0x0', 17:04:54 INFO - 'XPC_SERVICE_NAME': '0', 17:04:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:04:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:04:54 INFO - Cleaning up... 17:04:54 INFO - Return code: 0 17:04:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:04:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:54 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 0x10ba43490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9b9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6c2caf470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b857d30>, '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 0x10b67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b84fb20>, '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.Esp7xnFhCd/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.AecIwXk4i5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 17:04:54 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 17:04:54 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 17:04:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Esp7xnFhCd/Render', 17:04:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:04:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:04:54 INFO - 'HOME': '/Users/cltbld', 17:04:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:04:54 INFO - 'LOGNAME': 'cltbld', 17:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:54 INFO - 'MOZ_NO_REMOTE': '1', 17:04:54 INFO - 'NO_EM_RESTART': '1', 17:04:54 INFO - 'PAGER': '/bin/cat', 17:04:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:54 INFO - 'PWD': '/builds/slave/test', 17:04:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:04:54 INFO - 'SHELL': '/bin/bash', 17:04:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AecIwXk4i5/Listeners', 17:04:54 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 17:04:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:04:54 INFO - 'USER': 'cltbld', 17:04:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:04:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:54 INFO - 'XPC_FLAGS': '0x0', 17:04:54 INFO - 'XPC_SERVICE_NAME': '0', 17:04:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:04:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:54 INFO - Downloading/unpacking blobuploader==1.2.4 17:04:54 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 17:04:54 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 17:04:54 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 17:04:54 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 17:04:54 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 17:04:54 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 17:04:57 INFO - Downloading blobuploader-1.2.4.tar.gz 17:04:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:04:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:04:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04:58 INFO - Downloading docopt-0.6.1.tar.gz 17:04:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:04:58 INFO - Installing collected packages: blobuploader, requests, docopt 17:04:58 INFO - Running setup.py install for blobuploader 17:04:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:04:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:04:58 INFO - Running setup.py install for requests 17:04:59 INFO - Running setup.py install for docopt 17:04:59 INFO - Successfully installed blobuploader requests docopt 17:04:59 INFO - Cleaning up... 17:04:59 INFO - Return code: 0 17:04:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:04: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')]} 17:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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')]} 17:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:59 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 0x10ba43490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9b9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6c2caf470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b857d30>, '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 0x10b67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b84fb20>, '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.Esp7xnFhCd/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.AecIwXk4i5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 17:04:59 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 17:04:59 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 17:04:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Esp7xnFhCd/Render', 17:04:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:04:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:04:59 INFO - 'HOME': '/Users/cltbld', 17:04:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:04:59 INFO - 'LOGNAME': 'cltbld', 17:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:59 INFO - 'MOZ_NO_REMOTE': '1', 17:04:59 INFO - 'NO_EM_RESTART': '1', 17:04:59 INFO - 'PAGER': '/bin/cat', 17:04:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:59 INFO - 'PWD': '/builds/slave/test', 17:04:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:04:59 INFO - 'SHELL': '/bin/bash', 17:04:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AecIwXk4i5/Listeners', 17:04:59 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 17:04:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:04:59 INFO - 'USER': 'cltbld', 17:04:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:04:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:59 INFO - 'XPC_FLAGS': '0x0', 17:04:59 INFO - 'XPC_SERVICE_NAME': '0', 17:04:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:04:59 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-iddy25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:04:59 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-4k36l8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:04:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:04:59 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-kaRICP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:05:00 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-mYDWWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:05:00 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-VO6hzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:05:00 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-LfeV54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:05:00 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-m487_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:05:00 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-kCHpwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:05:00 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-3IK1px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:05:00 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-G27WRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:05:00 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-rSFKyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:05:00 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-F11MJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:05:01 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-rhaJQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:05:01 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-nxjqvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:05:01 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-i8eJX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:05:01 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-i8FUAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:05:01 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-Oi01VN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:05:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:05:01 INFO - Running setup.py install for manifestparser 17:05:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:05:01 INFO - Running setup.py install for mozcrash 17:05:01 INFO - Running setup.py install for mozdebug 17:05:01 INFO - Running setup.py install for mozdevice 17:05:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:05:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:05:02 INFO - Running setup.py install for mozfile 17:05:02 INFO - Running setup.py install for mozhttpd 17:05:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:05:02 INFO - Running setup.py install for mozinfo 17:05:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:05:02 INFO - Running setup.py install for mozInstall 17:05:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:05:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:05:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:05:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:05:02 INFO - Running setup.py install for mozleak 17:05:02 INFO - Running setup.py install for mozlog 17:05:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:05:03 INFO - Running setup.py install for moznetwork 17:05:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:05:03 INFO - Running setup.py install for mozprocess 17:05:03 INFO - Running setup.py install for mozprofile 17:05:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:05:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:05:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:05:03 INFO - Running setup.py install for mozrunner 17:05:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:05:03 INFO - Running setup.py install for mozscreenshot 17:05:03 INFO - Running setup.py install for moztest 17:05:03 INFO - Running setup.py install for mozversion 17:05:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:05:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:05:04 INFO - Cleaning up... 17:05:04 INFO - Return code: 0 17:05:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:05: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')]} 17:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05: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')]} 17:05:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba43490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9b9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6c2caf470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b857d30>, '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 0x10b67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b84fb20>, '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.Esp7xnFhCd/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.AecIwXk4i5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 17:05:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:05:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:05:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Esp7xnFhCd/Render', 17:05:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:05:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:05:04 INFO - 'HOME': '/Users/cltbld', 17:05:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:05:04 INFO - 'LOGNAME': 'cltbld', 17:05:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:04 INFO - 'MOZ_NO_REMOTE': '1', 17:05:04 INFO - 'NO_EM_RESTART': '1', 17:05:04 INFO - 'PAGER': '/bin/cat', 17:05:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:05:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:05:04 INFO - 'PWD': '/builds/slave/test', 17:05:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:05:04 INFO - 'SHELL': '/bin/bash', 17:05:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AecIwXk4i5/Listeners', 17:05:04 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 17:05:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:05:04 INFO - 'USER': 'cltbld', 17:05:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:05:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:05:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:04 INFO - 'XPC_FLAGS': '0x0', 17:05:04 INFO - 'XPC_SERVICE_NAME': '0', 17:05:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:05:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:05:04 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-7ht7Ut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:05:04 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-O1kzUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:05:04 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-jqvcZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:05:04 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)) 17:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:05:04 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-KCOtaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:05:04 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)) 17:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:05:04 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-fDH8mm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:05:04 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)) 17:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:05:04 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-WVH8dA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:05:05 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-kvhR7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:05:05 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-U1ENiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:05:05 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-K5loXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:05:05 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-SSmJ0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:05:05 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-amDr1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:05:05 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)) 17:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:05:05 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-sCWmLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:05:05 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)) 17:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:05:05 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-L2ZGn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:05:05 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)) 17:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:05:05 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-aASFUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:05:05 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-wpuRhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:05:06 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-QWP_gN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:05:06 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-C0UF45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:05:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:08 INFO - Downloading blessings-1.6.tar.gz 17:05:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:05:08 INFO - Installing collected packages: blessings 17:05:08 INFO - Running setup.py install for blessings 17:05:09 INFO - Successfully installed blessings 17:05:09 INFO - Cleaning up... 17:05:09 INFO - Return code: 0 17:05:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:05:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:05:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:05:09 INFO - Reading from file tmpfile_stdout 17:05:09 INFO - Current package versions: 17:05:09 INFO - blessings == 1.6 17:05:09 INFO - blobuploader == 1.2.4 17:05:09 INFO - docopt == 0.6.1 17:05:09 INFO - functools32 == 3.2.3-2 17:05:09 INFO - jsonschema == 2.5.1 17:05:09 INFO - manifestparser == 1.1 17:05:09 INFO - mozInstall == 1.12 17:05:09 INFO - mozcrash == 0.17 17:05:09 INFO - mozdebug == 0.1 17:05:09 INFO - mozdevice == 0.48 17:05:09 INFO - mozfile == 1.2 17:05:09 INFO - mozhttpd == 0.7 17:05:09 INFO - mozinfo == 0.9 17:05:09 INFO - mozleak == 0.1 17:05:09 INFO - mozlog == 3.4 17:05:09 INFO - moznetwork == 0.27 17:05:09 INFO - mozprocess == 0.23 17:05:09 INFO - mozprofile == 0.28 17:05:09 INFO - mozrunner == 6.12 17:05:09 INFO - mozscreenshot == 0.1 17:05:09 INFO - mozsystemmonitor == 0.3 17:05:09 INFO - moztest == 0.7 17:05:09 INFO - mozversion == 1.4 17:05:09 INFO - psutil == 3.1.1 17:05:09 INFO - requests == 1.2.3 17:05:09 INFO - wsgiref == 0.1.2 17:05:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:05: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')]} 17:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05: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')]} 17:05:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:09 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 0x10ba43490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9b9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6c2caf470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b857d30>, '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 0x10b67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b84fb20>, '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.Esp7xnFhCd/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.AecIwXk4i5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 17:05:09 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 17:05:09 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 17:05:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Esp7xnFhCd/Render', 17:05:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:05:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:05:09 INFO - 'HOME': '/Users/cltbld', 17:05:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:05:09 INFO - 'LOGNAME': 'cltbld', 17:05:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:09 INFO - 'MOZ_NO_REMOTE': '1', 17:05:09 INFO - 'NO_EM_RESTART': '1', 17:05:09 INFO - 'PAGER': '/bin/cat', 17:05:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:05:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:05:09 INFO - 'PWD': '/builds/slave/test', 17:05:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:05:09 INFO - 'SHELL': '/bin/bash', 17:05:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AecIwXk4i5/Listeners', 17:05:09 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 17:05:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:05:09 INFO - 'USER': 'cltbld', 17:05:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:05:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:05:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:09 INFO - 'XPC_FLAGS': '0x0', 17:05:09 INFO - 'XPC_SERVICE_NAME': '0', 17:05:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:05:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:09 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)) 17:05:09 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)) 17:05:09 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)) 17:05:09 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)) 17:05:09 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)) 17:05:09 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)) 17:05:09 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)) 17:05:09 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)) 17:05:09 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)) 17:05:09 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)) 17:05:09 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)) 17:05:09 INFO - Cleaning up... 17:05:09 INFO - Return code: 0 17:05:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:05: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')]} 17:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05: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')]} 17:05:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:09 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 0x10ba43490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b9b9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6c2caf470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b857d30>, '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 0x10b67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b84fb20>, '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.Esp7xnFhCd/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.AecIwXk4i5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 17:05:09 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 17:05:09 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 17:05:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Esp7xnFhCd/Render', 17:05:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:05:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:05:09 INFO - 'HOME': '/Users/cltbld', 17:05:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:05:09 INFO - 'LOGNAME': 'cltbld', 17:05:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:09 INFO - 'MOZ_NO_REMOTE': '1', 17:05:09 INFO - 'NO_EM_RESTART': '1', 17:05:09 INFO - 'PAGER': '/bin/cat', 17:05:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:05:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:05:09 INFO - 'PWD': '/builds/slave/test', 17:05:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:05:09 INFO - 'SHELL': '/bin/bash', 17:05:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AecIwXk4i5/Listeners', 17:05:09 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 17:05:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:05:09 INFO - 'USER': 'cltbld', 17:05:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:05:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:05:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:09 INFO - 'XPC_FLAGS': '0x0', 17:05:09 INFO - 'XPC_SERVICE_NAME': '0', 17:05:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:05:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:05:09 INFO - Cleaning up... 17:05:09 INFO - Return code: 0 17:05:09 INFO - Running post-action listener: _resource_record_post_action 17:05:09 INFO - Running post-action listener: _start_resource_monitoring 17:05:10 INFO - Starting resource monitoring. 17:05:10 INFO - [mozharness: 2016-11-06 00:05:10.008053Z] Finished create-virtualenv step (success) 17:05:10 INFO - [mozharness: 2016-11-06 00:05:10.009118Z] Running install step. 17:05:10 INFO - Running pre-action listener: _resource_record_pre_action 17:05:10 INFO - Running main action method: install 17:05:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:05:10 INFO - Reading from file tmpfile_stdout 17:05:10 INFO - Detecting whether we're running mozinstall >=1.0... 17:05:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:05:10 INFO - Reading from file tmpfile_stdout 17:05:10 INFO - Output received: 17:05:10 INFO - Usage: mozinstall [options] installer 17:05:10 INFO - Options: 17:05:10 INFO - -h, --help show this help message and exit 17:05:10 INFO - -d DEST, --destination=DEST 17:05:10 INFO - Directory to install application into. [default: 17:05:10 INFO - "/builds/slave/test"] 17:05:10 INFO - --app=APP Application being installed. [default: firefox] 17:05:10 INFO - mkdir: /builds/slave/test/build/application 17:05:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:05:44 INFO - Reading from file tmpfile_stdout 17:05:44 INFO - Output received: 17:05:44 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:05:44 INFO - Running post-action listener: _resource_record_post_action 17:05:44 INFO - [mozharness: 2016-11-06 00:05:44.383153Z] Finished install step (success) 17:05:44 INFO - [mozharness: 2016-11-06 00:05:44.383284Z] Running run-tests step. 17:05:44 INFO - Running pre-action listener: _resource_record_pre_action 17:05:44 INFO - Running main action method: run_tests 17:05:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:05:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:05:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:05:44 INFO - 2016-11-05 17:05:44.397 screenresolution[1649:7886] starting screenresolution argv=screenresolution get 17:05:44 INFO - 2016-11-05 17:05:44.400 screenresolution[1649:7886] Display 0: 1600x1200x32@60 17:05:44 INFO - 2016-11-05 17:05:44.406 screenresolution[1650:7888] starting screenresolution argv=screenresolution list 17:05:44 INFO - Available Modes on Display 0 17:05:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:05:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:05:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:05:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:05:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:05:44 INFO - Intel Iris: 17:05:44 INFO - Chipset Model: Intel Iris 17:05:44 INFO - Type: GPU 17:05:44 INFO - Bus: Built-In 17:05:44 INFO - VRAM (Dynamic, Max): 1536 MB 17:05:44 INFO - Vendor: Intel (0x8086) 17:05:44 INFO - Device ID: 0x0a2e 17:05:44 INFO - Revision ID: 0x0009 17:05:44 INFO - Displays: 17:05:44 INFO - Display: 17:05:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:05:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:05:44 INFO - Display Serial Number: 1600x1200 60 17:05:44 INFO - Main Display: Yes 17:05:44 INFO - Mirror: Off 17:05:44 INFO - Online: Yes 17:05:44 INFO - Rotation: Supported 17:05:44 INFO - Return code: 0 17:05:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:05:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:05:44 INFO - Python 2.7.3 17:05:44 INFO - Return code: 0 17:05:44 INFO - grabbing minidump binary from tooltool 17:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:44 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 0x10b857d30>, '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 0x10b67ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b84fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:05:44 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 17:05:44 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 17:05:44 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 17:05:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:05:44 INFO - Return code: 0 17:05:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:05:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:05:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:05:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:05:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:05:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TjvhzVnfQuqS64A_Z0tXhA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0090', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:05:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TjvhzVnfQuqS64A_Z0tXhA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0090 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:05:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Esp7xnFhCd/Render', 17:05:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:05:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:05:44 INFO - 'HOME': '/Users/cltbld', 17:05:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:05:44 INFO - 'LOGNAME': 'cltbld', 17:05:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:05:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:44 INFO - 'MOZ_NO_REMOTE': '1', 17:05:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:05:44 INFO - 'NO_EM_RESTART': '1', 17:05:44 INFO - 'PAGER': '/bin/cat', 17:05:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:05:44 INFO - 'PWD': '/builds/slave/test', 17:05:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:05:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:05:44 INFO - 'SHELL': '/bin/bash', 17:05:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AecIwXk4i5/Listeners', 17:05:44 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 17:05:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:05:44 INFO - 'USER': 'cltbld', 17:05:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:05:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:44 INFO - 'XPC_FLAGS': '0x0', 17:05:44 INFO - 'XPC_SERVICE_NAME': '0', 17:05:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:05:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TjvhzVnfQuqS64A_Z0tXhA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0090', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:05:44 INFO - mozversion application_buildid: 20161105145229 17:05:44 INFO - mozversion application_changeset: 7ccf894aacb0840b8e06e028abe1d494c5c001c5 17:05:44 INFO - mozversion application_display_name: Nightly 17:05:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:05:44 INFO - mozversion application_name: Firefox 17:05:44 INFO - mozversion application_remotingname: firefox 17:05:44 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 17:05:44 INFO - mozversion application_vendor: Mozilla 17:05:44 INFO - mozversion application_version: 52.0a1 17:05:44 INFO - mozversion platform_buildid: 20161105145229 17:05:44 INFO - mozversion platform_changeset: 7ccf894aacb0840b8e06e028abe1d494c5c001c5 17:05:44 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 17:05:44 INFO - mozversion platform_version: 52.0a1 17:05:44 INFO - using testdate: 1478390744 17:05:44 INFO - actual date: 1478390744 17:05:44 INFO - starting webserver on 'localhost:49273' 17:05:44 INFO - SUITE-START | Running 2 tests 17:05:44 INFO - TEST-START | dromaeo_css 17:05:44 INFO - operating with platform_type : mac_ 17:05:44 INFO - Initialising browser for dromaeo_css test... 17:05:45 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmppHPAyZ/profile http://localhost:49273/getInfo.html) 17:05:47 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 17:05:47 INFO - PROCESS | 1660 | colorDepth:24 17:05:47 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 17:05:47 INFO - PROCESS | 1660 | __metrics 17:05:47 INFO - PROCESS | 1660 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:05:47 INFO - PROCESS | 1660 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:05:48 INFO - TEST-INFO | 1660: exit 0 17:05:48 INFO - Browser initialized. 17:05:48 INFO - Running cycle 1/1 for dromaeo_css test... 17:05:48 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmppHPAyZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:06:00 INFO - PROCESS | 1662 | RSS: Main: 233353216 17:06:00 INFO - PROCESS | 1662 | 17:06:52 INFO - PROCESS | 1662 | 1478390812033 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] 17:09:04 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 17:09:06 INFO - PROCESS | 1662 | RSS: Main: 394072064 17:09:06 INFO - PROCESS | 1662 | 17:12:09 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 17:12:09 INFO - PROCESS | 1662 | RSS: Main: 378265600 17:12:09 INFO - PROCESS | 1662 | 17:15:12 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 17:15:12 INFO - PROCESS | 1662 | RSS: Main: 337649664 17:15:12 INFO - PROCESS | 1662 | 17:18:15 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 17:18:15 INFO - PROCESS | 1662 | RSS: Main: 346931200 17:18:15 INFO - PROCESS | 1662 | 17:21:19 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 17:21:19 INFO - PROCESS | 1662 | RSS: Main: 332967936 17:21:19 INFO - PROCESS | 1662 | 17:24:22 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 17:24:23 INFO - PROCESS | 1662 | RSS: Main: 425668608 17:24:23 INFO - PROCESS | 1662 | 17:24:23 INFO - PROCESS | 1662 | __start_tp_report 17:24:23 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 17:24:23 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 17:24:23 INFO - PROCESS | 1662 | |i|pagename|runs| 17:24:23 INFO - PROCESS | 1662 | |0;dojo.html;3285.884994025209;3305.140663427508;3338.13208565773;3338.432466480698;3365.259642878566;5503.807366742165;5505;5620.409856965021;5656;5687;5581.944180558193;5647.407022262654;5733.942660573393;5740.253767010293;5743.425657434254;5007.4992500749995;5064.290999260106;5111.718855462948;5154.278401023859;5162.199859021857;4522.819087236507;5202.92195617066;5245.134552798783;5247.39654939683;5299.920501192485;5018.698878067291;5182.481751824825;5196.714180720059;5201;5277.366715994067;5073.289739436482;5125.666831655931;5133.332666753336;5135.152699804527;5142.665726727751;5025.396952365703;5081.034603425374;5102.132637451642;5118.872028199287;5122.359705036871;5582.665040097607;5612.15817627355;5616.747246373923;5620.185073164368;5622.550195984352;6069.757209711606;6072.180255665517;6080.847978800522;6083.239595050619;6085.3914608539235;6131.988406491147;6143.569950103494;6143.911070236097;6145.139680444741;6154.76904619078;5650.63270887391;5694.601377903548;5774.2782152230975;5775.942240577582;5818.8254352369495;6206.472449841814;6213.906791398133;6255.812325630239;6279.560430769893;6281.183446152062;6082.695865206722;6097.146399504073;6109.572329936862;6111.052786818051;6120.677614382366;6029.336772954972;6115.602485838406;6116.816495505142;6126.816195514141;6157.2611286645;6167.889779839672;6181.84545386369;6182.319944806068;6182.721777520022;6186.907196392058;6175.907361389583;6199.225096862892;6207.099970504251;6214.502839772807;6230.06549017651;4779.665423420397;4846.7818948147415;4848.127337079289;4876.975615121902;4934.55588996992;4353.934690979638;4361.869143925687;4392.824287028547;4415.072834704748;4465.285554311295;5749.9712501437225;5772.047612144033;5772.855678608068;5775.249217601685;5781.19063331134;5967.373425790316;6251.687415629201;6262.843428914313;6273.027680709406;6283.088952102011;5633.211350410946;5691.573132015115;5697.03150464422;5703.686297253608;5717.514011309002;5301.363836339664;5318.521333079964;5371.838844834661;5423.810166644149;5423.918641220384;6256;6269.435750782452;6275.5607107503865;6284.308726040132;6293.748250070129;6251.874962500816;6276.748930042747;6302.779402720883;6309.400606942333;6318.368163183645;6203.16257305276;6229.56393052482;6259.499240060875;6269.623822570478;6277.937220627918;6115.235595550556;6144.53915956314;6145.569810113249;6151.323354431099;6159.353267906805;6173.59871608344;6226.097215903759;6240.812775616739;6254.124422580751;6260.060990851227;5822.417758224144;5882.852928676817;6023.1868697726995;6037.366076562073;6041.728122234422;5274.736263186748;5789.465791565154;5916.526677865674;5919.733611987384;5960.970195148997;5853.678047707417;5856.12158176277;5857.326407463196;5863.882722345615;5874.823755287348;4788.066327066189;5976.193213916065;6017.909731354121;6032.245969253843;6048.697565121638;5686.289213848269;5733.5126514245085;5746.712664366849;5794.478496935128;5823.417658234142 17:24:23 INFO - PROCESS | 1662 | |1;ext.html;458.68121655449454;466.40533320016976;495.96032317414597;513.2532165698907;534.6524758906712;30381.240468988257;38274.85175444738;38939.610603893954;40388.79805600968;42483.787581062126;41549;42049.369259461135;42107.78946105265;42139.94650133748;42271.87057876614;9229.861552076707;9382.953085234598;9412;9412.764680882998;9418.246540276796;9289.907100928971;9381;9397.342186046979;9397.530123493798;9407.623695052189;9311.255099592016;9357.625694972194;9369.15677589017;9378.906210937872;9382.29632777541;9334.579943902541;9359.532023398871;9360.251179905592;9364.95317523408;9372.765680857965;8003;9359.251259899193;9365.812683746355;9379.718608441757;9382.718518444457;38978.41532377017;39389.80305098456;39435.60564394348;39450.60549394498;39547.61583344569;3385.6275809661165;3479.0432631026415;3499.527563778908;3657.6342365763476;3734.3278209922205;29697.851510742308;29704.554431683326;30160.396792064035;30472.695273047208;31293;3133.9216519586967;3152.795068320575;3175.2320019015665;3232.87068517259;3261.7390608751243;470422.6478867618;473522;473756;473923.6303818493;474259;57966.710166448895;58384.99380074418;58442;58468.415315847145;58570.70714646485;33770.83114584412;34333.14167145841;34682.65317346845;61025.69487152536;61480.07779883305;15660;15697.607559811097;15723.764143537855;15751.606209844846;15753.369865205263;10404.427756473315;12293.385330733428;12377.876221237853;12378.257304561756;12391.442385092692;18358.908205459153;18496.982665953234;18556.164972576265;18582.907085464485;18628.906855465637;6597.703103360361;7572.6903294495705;7627.313541781266;7678.424118191158;7733.883991740128;748.3751067858399;961.6489981156827;995.7012896131132;1022.483645758887;1062.6015244283394;29150.708492915222;29335.413291734472;29413.264668383035;30229.09312720622;30336.54495182574;900.6892622045384;1000.4347543637822;1008.4503945349655;1029.6602121299952;1052.8473371361263;14902.70194596102;15070.397184112731;15124.319405626773;15266.847331526764;15459.227038648023;664691;667378;668995;669001;670850;56568;56922;56997.715011425506;57019.42980570224;57055.42944570584;1329.8071779591905;1347.3330701302918;1359.884409825176;1362.5707902010836;1362.6048445950762;28089;28999.85500072486;29108.854455727585;29812.701872980993;30146;49824.25263620976;50143.498565013884;50200;50233.74883125561;50299.99400011906;477921;479823;481928;481986;482821.8589070462;25938.221853343675;26273.737262627892;26281.868590656923;26361.60457593176;26421.867890660425;43947.56052439435;44138.55861441344;44483.55516444794;45736.771316143204;45864.31203532017;35051;36996.44505332476;37340;38154.42768358421;38630.034249142875;36817;37047.81476092602;37978.81010594929;38340;38361;36222.8188859054;36637.08407289839;37490;37760.43359349557;37801.054973625876;31842.36315273635;32654.34691306208;33655;35120.824395877855;35375;20050.498737531678;21579.13683452644;22977.017027549115;25030.37424064413;25322.366940826625 17:24:23 INFO - PROCESS | 1662 | |2;jquery.html;355.12816036630073;369.20989083361627;375.4555893953767;384.3984164782117;404.548927945341;14276.286185690713;14558.980871338998;15618.453354132593;19551.02244887757;20112;18960.62078758424;19365.838049717026;19644.803551964476;20024.199032038738;20247;5760.107183386572;6057;6062.818115456521;6072.908906366408;6078.240219972504;4178.770167640779;4417.403650507189;4545.477270113946;5980.162777211194;6060.090986352038;4420.0938807544535;6379.776707815227;6692.732290708366;6732.249615100085;6780.355866192704;6464.870702585969;6643.368879956396;6694.2970988046045;6707.5975441473665;6761.323867613224;4955.35580374549;5725.083986562172;5802.390748971382;5812.534997200214;5815.185873977604;24410.755892441026;24637.63043554348;25173.24480265595;25174.874125629438;25359.366015849566;2114.143771772435;2145.1955516681246;2339.63735620979;2531.923932328771;2711.8372897626205;5564.360098588673;5658.74535645897;14408.351624176938;14465.638359041002;15321.310541025681;1842.5762074722888;1843.3363988963963;1858.9628207435776;1876.4988009592407;1898.9870737018666;110862;110993.44503277513;114630;114669;117153;11244.887551124548;11319.377434241196;11433.885661143448;11496.94251528737;11548;14242.643933901529;14292.642683932776;14311.928440357731;14318.785218221736;14329;7885.29032387088;8049.959750201211;8113.148119447373;8257.669693212205;8293.95853020731;6766.458683305324;7933.761987140395;8075.313598344206;8095.352371810359;8121.837563248702;3897.240038192582;4360.912781744348;4362.563743625612;4471.396361491222;4545.704529205591;1753.587906841891;1790.2738808360923;1847.1041544850736;1935.400025991947;1945.6886898096236;772.5712229712564;785.7721260834294;941.868138460616;951.4291425144858;978.8629591857145;15468.381264749509;19389.51526211828;20370.79629203689;20390.490237744176;20479.795202048088;884.3632584539122;892.5894088719261;895.8253140637644;955.383777463546;963.9180669643018;10248.48757562119;10795;10795.406252656023;10801.891981080245;10833.945830270799;551599.2420037874;570328;570554.4722763845;587326;588268;80921;110684;113557;122845;122971.15543266859;914.5747227539226;928.5542939389131;958.5399008475971;958.7075941837667;959.1607343574373;17919.580856584715;18065.54836129055;18110.81889181144;18138.909305453915;18478.353257635918;36314.455283170246;44373;52090.47909520856;52107;52896.20655690245;71996.64001679957;72587.27412725805;73466;73522.63238683772;74228.25771742214;7480.588567628833;7689.846203076019;7787;7956.403269754675;7975.99525487589;10762.838557421488;10976.945115274373;11855.703607409883;12253.877461225631;12263.448144833683;10180.338278011906;10216.948915255376;10543.103836174012;10591.299218699183;10730.409827459565;10565.524551395052;10666.62666806689;10787.190960678137;10912.563497460013;10938.234323597271;8535.274501667427;10469.633562825264;11044.723881903017;11067.557297708001;11158.386288754196;7798.922010779819;7969.800754981172;8056;8140;8221.383396245425;8968.237699795329;10158.847617285894;10595;10846.511906964048;10867.619633312795 17:24:23 INFO - PROCESS | 1662 | |3;mootools.html;1304.6347022833606;1446.2045874768874;1580.6206510437498;1799.5681036551216;1834.0829585207389;8023.117457079724;8435.70475033374;8465.111163327854;8465.19580639839;8468.703595374156;6055.697215139247;7692.3076923076915;7699.268569485904;8040.155783642721;8264.95867520663;2276.430892276931;2314.109068008812;2314.317276403465;2317.0731707317123;2321.0483701682315;2309.6535519672016;2353.6116540770754;2361.3624321433203;2364.467994701187;2365.7634236576378;2301.620232661609;2305.7348404933477;2332.0088962191085;2335.995521925571;2338.8245881558864;2293.4266433391654;2301.551197516485;2320.234322673514;2324.5118525109665;2326.348622385735;2316.293530473205;2337.235387282608;2338.4270853640796;2339.309903578431;2341.2039906431723;8351.665933362658;8411.873821892677;8420.915790842075;8429.409941304111;8462.15378462155;5028.270900719412;5192.55863251624;5192.740362981874;5196.376434827807;5205.713685747282;2856.48583255014;3156.1320636825058;3335.7664963452567;3477.1654802847133;3481.2863363010524;1052.3760212853488;1057.3814318623615;1085.2240647936685;1104.690686607751;1104.9944750276197;10817.405042722647;10913.890861091368;10966.945165274203;10972.23194376394;10992.560297588087;4357.237483440385;4510.970063471451;4589.059242855206;4593.242115051046;4635.351050852883;9373.671921482715;9387.483688397204;9392.577334019985;9394.483303418378;9397.483138427453;5169.043726910533;5173.974130129325;5177.7152256625495;5178.870528236825;5180.109260120104;3976.8608098716404;4367.410399596078;4396.824127034947;4608.470025946992;4725.881852953635;2933.515969864991;3377.611574668895;3642.927141457156;3762.2663580602066;3800.4869342638945;1247.0833937056439;1250.5685538489206;1257.4530079415301;1263.5577547858177;1268.315109840694;735.5366119344885;772.7334069746041;789.8459800338994;817.7260617693021;819.7049062337554;5438.646487978269;5443.591730620219;5576.10782274834;5670.489655930986;5707.315122185364;426.75461609574;429.35090491666494;431.24101581216655;437.8401883312568;440.27354864473233;3586.497890295361;3736.1593641431004;3785.930125115512;3818.656320931074;3849.7882616455804;8153.673853045931;10026.298159128937;10070.496475176213;10071.34536255141;10092.697219083439;9915;9920.553575088994;9939.751506212402;9947.651832185984;10044.899551004542;7702.152763195932;7754.806129846686;7875.645595948196;7879.448438609357;7891.6054197289905;5401.9736250112355;5477.370102438112;5543.307086614173;5577.386487486292;5604.159376093618;9296.116868897443;9382.249420046244;9386.342955993015;9387.718368448684;9402.2948278878;9203.263738901005;9355.672551460939;9476.810463790824;9489;9589.328746987643;6973.12835895513;7036.859262814817;7038.40173585251;7148.320909513588;7161.641917903979;7734.26524480196;7843.647035883513;7849.411294152847;7860.410469214946;7864.84270314602;6072.301685306246;6757.526973112032;6927.618980956096;6958.79123626292;7133.82165445868;6979.092717946634;6983.546069505669;6984.930150698428;6989.615571143432;7049.08361912948;6464.5798023128345;6555.934440655532;6590;6630.270670226175;6642.4021838034805;4767.880802979953;4803.543663351976;4821.397325334333;4894.828680996148;4982.003599280086;4808.110499557593;4864.8054077837905;4895.779689914034;4928.457869634266;4947.282644016669 17:24:23 INFO - PROCESS | 1662 | |4;prototype.html;301.83097465419365;302.38615610311075;310.8010873041253;316.4635942078177;317.4048658764816;4789.952100478994;4894.388201474816;5129.281900533923;5142.7371956339275;5210.505002024806;4201.831926722935;5037.319961805155;5057.367829021372;5077.339945807049;5095.261187127864;3681.2821499807546;3835.213781174866;3840.5391353037603;4024.235395274903;4037.313656678372;3283.40898638245;3697.2235830475634;3901.8294511646536;3949.7630142191415;4036.2129384769983;3328.900132996014;3898.5321761388673;3924.1759230561615;3933.193695292458;3938.1926705025544;3875.6511913927743;3909.76541407515;3914.5106861642294;3929.332013557702;3931.9410208846602;3125.64055133658;3187.856546455415;3399.538198574612;3407.5570175877224;3426.554547908756;3776.6412190841825;4402.163588918095;4403.2954727243805;5035.798568057273;5042.865355295066;4435.7338559686195;4459.416906998002;4478.440194975628;4486.865394038152;4505.008898042458;5040.521150490697;5241.580673546107;5280.445553216895;5397.568194544427;5398.163284690879;3232.755389175161;3423.9043506078065;3472.7742696724886;3557.239166612543;3776.6978641708597;4845.975770121162;5722.334888460436;5761.48146666802;5786.392428794958;5787.855303617401;3388.728901687859;3797.35444974355;3822.7897465639103;3837.3860182370686;3844.2503711775935;3872.6320999505;3884.9611503885167;3886.766793992313;3887.5723670396233;3899.863504777319;3755.3615885299564;4030.234255491506;4462.977685111554;4512.503624601291;4554.817807287672;4671.5328467153695;5460.143551192614;5492;5499.40517250001;5508.457631863084;1083.8619449577911;1168.3340495917416;1194.7013246688327;1224.9632511024683;1226.8405107335989;835.5529791561486;851.2126283188027;855.3969451536652;857.3355649371787;862.9568521573896;4159.667226621863;4222.05003874132;4648.490389755712;4704.929426058612;4729.597984171384;4903;5184.874201577335;5248.448912864171;5280.6039547034125;5317.388500322512;3995.5005624296964;4464.86605401832;4589.567529209524;4716.88207794801;4780.354652121919;2565.4484285878625;2744.423671029106;2750.3261700883413;2751.697313295536;2765.7510824025935;4818.783359654598;4955.058538877602;5349.144136938071;5361.651492652965;5374.211181117303;4741.241401375763;5151.793928242903;5185.033449411203;5191.779931716043;5289.20661900718;4435.911281774411;4797.928031079537;5183.611229157828;5314.734263286898;5325.700927577085;4657.487676355666;4753.809847606057;4799.448063472745;5159.251908473176;5209.53114219722;4091.97954010228;4317.589828966243;4359.455068116486;4785.569298763128;5168.638195326442;4983.975080124721;5006.374203224597;5348.866278342917;5356.5714742821265;5364.007658583175;3255.2187475006303;3318.0377690469495;3528.6647768461953;3584.6662603778736;3649.233660931234;4517.570830771203;4960;5100;5131.434912351769;5193.506616871391;4681.882952926204;4896.314515967696;5257.710825904459;5572.387037425961;5579.2746942897165;5491.341039075336;5514.24287856072;5520.779168833202;5546.805861794818;5554.305711786027;5210.557102646318;5416.2688037114485;5432.972835135799;5498.422665620053;5524.502794748492;5439.347278326468;5458.235846981505;5492.972535137299;5494.945050549603;5516.951779161946;5204.635675502678;5355.563218735544;5360.678359298455;5399.919001215064;5400.351957764936 17:24:23 INFO - PROCESS | 1662 | |5;yui.html;582.8921649494841;661.8841702702028;677.7864972533652;705.6260182103487;713.3615414204286;13472.865271347284;14061.296935153252;14062.718745625081;14079.929600351998;14331.64170895728;12657.114002019862;12748.617541473748;12759.553415630455;12764.234145951226;12779.680507987305;814.9185081491863;823.6746485138367;825.1006403020706;828.6519661742053;828.8508068547659;822.8560001999656;822.8642274024809;823.6087858267305;824.9298809601191;827.2843989948711;816.2449733996029;854.0520022774715;869.0527325215514;869.3349587565517;872.9738107856774;848.3298194426427;859.1537335724306;862.784303924019;864.3992425264444;866.3978534918234;645.6223109480959;645.6771614192903;645.7675236914707;646.809191288571;647.7473785223766;10848.891511084867;13900.582982510541;13949.163050216917;13970.720585588333;13972.720545589133;10170.644027459004;12122.090843186708;12574.81137782934;13009;13072.738545229042;10697.358158510437;10874.61938832145;10897.67306980792;10979.945100274448;10982.560697572088;3521.7710848794745;3598.514200582914;3607.313866077868;3667.8166091695575;3687.612800655946;92854.53572732094;93023;93985;95532;95945;9735.756606084904;9936.801263974825;10176.236782241214;10228.846567301496;10386.740331491623;18799.530011749543;18937.33719319817;19127.904360478387;19168.520786980436;19259.51851203731;7366.558006519626;7475.215102414277;7495.400367970549;7536.660850261642;7619.580923049286;3997.2804895119157;4109.239790638741;4148.087420767487;4159.251334759772;4303.526612072669;3177.7934434261697;3234.6280177779386;3248.1717162123978;3289.5394644749754;3291.9341613167603;605.866709323948;605.975760969565;620.8882401167742;625.3215261441387;628.133176216827;442.10032583692674;596.8537708261417;603.8399824046631;613.123233775705;613.1599708399522;8129.349652027823;8407.95796021016;8533.74398768038;8542.402031857835;8657.307415406753;502.8491452564216;517.7928828468642;602.1389413139166;615.8398816307703;618.9690515474208;3592.8023958682;3653.397189463709;3864.903377415531;4008.677136544933;4045.615666511677;69213;96618.06763864684;109908.054137564;113887.72224555463;115155.42422288003;64002.35997639964;78284.21715782883;93401.5329923346;94629;100822.4958875201;26475.86762066216;59548.40451595515;85517.71723424029;86131.56934215414;87832;8103.6758529658155;8170.632321545663;8190.672373105247;8240.793980150544;8281.917180828115;40281.395779062754;50891.49108508867;52500.7374963138;55239.44760552343;56142.719286403306;78798;79602.40795183949;81734.59132704299;82152;83953.58023209845;7687.346575541142;10553.050225479743;10562.102221311274;10572.629957951434;10800.189985750943;11694.532218711156;11725.41372931367;11798.705032374259;12095.57665481704;12259;10747.247692661438;11153.442327883411;11183.552657893593;11358.488868001125;11494.252873563191;10748.086412655011;11110.722231944266;11208.887911120784;11518.884811152117;11562;9808.117269445784;10740.033396994308;10782;10947.781044378908;11107.333559986426;8708.28152200945;9186.770330741785;9210.723678289662;9520.714378568655;9554.378965367228;9316.627334906529;9480;9503.892992613406;9604.375715578464;9651.517424128626 17:24:23 INFO - PROCESS | 1662 | __end_tp_report 17:24:23 INFO - PROCESS | 1662 | __start_cc_report 17:24:23 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1616 17:24:23 INFO - PROCESS | 1662 | __end_cc_report 17:24:23 INFO - PROCESS | 1662 | __startTimestamp1478391863143__endTimestamp 17:24:23 INFO - PROCESS | 1662 | 17:24:23 INFO - PROCESS | 1662 | ------- Summary: start ------- 17:24:23 INFO - PROCESS | 1662 | Number of tests: 6 17:24:23 INFO - PROCESS | 1662 | 17:24:23 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5673.55 Median:5822.42 stddev:643.74 (11.1%) stddev-sans-first:617.86 17:24:23 INFO - PROCESS | 1662 | Values: 3285.9 3305.1 3338.1 3338.4 3365.3 5503.8 5505.0 5620.4 5656.0 5687.0 5581.9 5647.4 5733.9 5740.3 5743.4 5007.5 5064.3 5111.7 5154.3 5162.2 4522.8 5202.9 5245.1 5247.4 5299.9 5018.7 5182.5 5196.7 5201.0 5277.4 5073.3 5125.7 5133.3 5135.2 5142.7 5025.4 5081.0 5102.1 5118.9 5122.4 5582.7 5612.2 5616.7 5620.2 5622.6 6069.8 6072.2 6080.8 6083.2 6085.4 6132.0 6143.6 6143.9 6145.1 6154.8 5650.6 5694.6 5774.3 5775.9 5818.8 6206.5 6213.9 6255.8 6279.6 6281.2 6082.7 6097.1 6109.6 6111.1 6120.7 6029.3 6115.6 6116.8 6126.8 6157.3 6167.9 6181.8 6182.3 6182.7 6186.9 6175.9 6199.2 6207.1 6214.5 6230.1 4779.7 4846.8 4848.1 4877.0 4934.6 4353.9 4361.9 4392.8 4415.1 4465.3 5750.0 5772.0 5772.9 5775.2 5781.2 5967.4 6251.7 6262.8 6273.0 6283.1 5633.2 5691.6 5697.0 5703.7 5717.5 5301.4 5318.5 5371.8 5423.8 5423.9 6256.0 6269.4 6275.6 6284.3 6293.7 6251.9 6276.7 6302.8 6309.4 6318.4 6203.2 6229.6 6259.5 6269.6 6277.9 6115.2 6144.5 6145.6 6151.3 6159.4 6173.6 6226.1 6240.8 6254.1 6260.1 5822.4 5882.9 6023.2 6037.4 6041.7 5274.7 5789.5 5916.5 5919.7 5961.0 5853.7 5856.1 5857.3 5863.9 5874.8 4788.1 5976.2 6017.9 6032.2 6048.7 5686.3 5733.5 5746.7 5794.5 5823.4 17:24:23 INFO - PROCESS | 1662 | 17:24:23 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:66868.42 Median:38784.82 stddev:146610.96 (378.0%) stddev-sans-first:146937.45 17:24:23 INFO - PROCESS | 1662 | Values: 458.7 466.4 496.0 513.3 534.7 30381.2 38274.9 38939.6 40388.8 42483.8 41549.0 42049.4 42107.8 42139.9 42271.9 9229.9 9383.0 9412.0 9412.8 9418.2 9289.9 9381.0 9397.3 9397.5 9407.6 9311.3 9357.6 9369.2 9378.9 9382.3 9334.6 9359.5 9360.3 9365.0 9372.8 8003.0 9359.3 9365.8 9379.7 9382.7 38978.4 39389.8 39435.6 39450.6 39547.6 3385.6 3479.0 3499.5 3657.6 3734.3 29697.9 29704.6 30160.4 30472.7 31293.0 3133.9 3152.8 3175.2 3232.9 3261.7 470422.6 473522.0 473756.0 473923.6 474259.0 57966.7 58385.0 58442.0 58468.4 58570.7 33770.8 34333.1 34682.7 61025.7 61480.1 15660.0 15697.6 15723.8 15751.6 15753.4 10404.4 12293.4 12377.9 12378.3 12391.4 18358.9 18497.0 18556.2 18582.9 18628.9 6597.7 7572.7 7627.3 7678.4 7733.9 748.4 961.6 995.7 1022.5 1062.6 29150.7 29335.4 29413.3 30229.1 30336.5 900.7 1000.4 1008.5 1029.7 1052.8 14902.7 15070.4 15124.3 15266.8 15459.2 664691.0 667378.0 668995.0 669001.0 670850.0 56568.0 56922.0 56997.7 57019.4 57055.4 1329.8 1347.3 1359.9 1362.6 1362.6 28089.0 28999.9 29108.9 29812.7 30146.0 49824.3 50143.5 50200.0 50233.7 50300.0 477921.0 479823.0 481928.0 481986.0 482821.9 25938.2 26273.7 26281.9 26361.6 26421.9 43947.6 44138.6 44483.6 45736.8 45864.3 35051.0 36996.4 37340.0 38154.4 38630.0 36817.0 37047.8 37978.8 38340.0 38361.0 36222.8 36637.1 37490.0 37760.4 37801.1 31842.4 32654.3 33655.0 35120.8 35375.0 20050.5 21579.1 22977.0 25030.4 25322.4 17:24:23 INFO - PROCESS | 1662 | 17:24:23 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:33134.62 Median:18334.79 stddev:95468.12 (520.7%) stddev-sans-first:95704.21 17:24:23 INFO - PROCESS | 1662 | Values: 355.1 369.2 375.5 384.4 404.5 14276.3 14559.0 15618.5 19551.0 20112.0 18960.6 19365.8 19644.8 20024.2 20247.0 5760.1 6057.0 6062.8 6072.9 6078.2 4178.8 4417.4 4545.5 5980.2 6060.1 4420.1 6379.8 6692.7 6732.2 6780.4 6464.9 6643.4 6694.3 6707.6 6761.3 4955.4 5725.1 5802.4 5812.5 5815.2 24410.8 24637.6 25173.2 25174.9 25359.4 2114.1 2145.2 2339.6 2531.9 2711.8 5564.4 5658.7 14408.4 14465.6 15321.3 1842.6 1843.3 1859.0 1876.5 1899.0 110862.0 110993.4 114630.0 114669.0 117153.0 11244.9 11319.4 11433.9 11496.9 11548.0 14242.6 14292.6 14311.9 14318.8 14329.0 7885.3 8050.0 8113.1 8257.7 8294.0 6766.5 7933.8 8075.3 8095.4 8121.8 3897.2 4360.9 4362.6 4471.4 4545.7 1753.6 1790.3 1847.1 1935.4 1945.7 772.6 785.8 941.9 951.4 978.9 15468.4 19389.5 20370.8 20390.5 20479.8 884.4 892.6 895.8 955.4 963.9 10248.5 10795.0 10795.4 10801.9 10833.9 551599.2 570328.0 570554.5 587326.0 588268.0 80921.0 110684.0 113557.0 122845.0 122971.2 914.6 928.6 958.5 958.7 959.2 17919.6 18065.5 18110.8 18138.9 18478.4 36314.5 44373.0 52090.5 52107.0 52896.2 71996.6 72587.3 73466.0 73522.6 74228.3 7480.6 7689.8 7787.0 7956.4 7976.0 10762.8 10976.9 11855.7 12253.9 12263.4 10180.3 10216.9 10543.1 10591.3 10730.4 10565.5 10666.6 10787.2 10912.6 10938.2 8535.3 10469.6 11044.7 11067.6 11158.4 7798.9 7969.8 8056.0 8140.0 8221.4 8968.2 10158.8 10595.0 10846.5 10867.6 17:24:23 INFO - PROCESS | 1662 | 17:24:23 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5377.22 Median:5098.66 stddev:2984.96 (58.5%) stddev-sans-first:2977.64 17:24:23 INFO - PROCESS | 1662 | Values: 1304.6 1446.2 1580.6 1799.6 1834.1 8023.1 8435.7 8465.1 8465.2 8468.7 6055.7 7692.3 7699.3 8040.2 8265.0 2276.4 2314.1 2314.3 2317.1 2321.0 2309.7 2353.6 2361.4 2364.5 2365.8 2301.6 2305.7 2332.0 2336.0 2338.8 2293.4 2301.6 2320.2 2324.5 2326.3 2316.3 2337.2 2338.4 2339.3 2341.2 8351.7 8411.9 8420.9 8429.4 8462.2 5028.3 5192.6 5192.7 5196.4 5205.7 2856.5 3156.1 3335.8 3477.2 3481.3 1052.4 1057.4 1085.2 1104.7 1105.0 10817.4 10913.9 10966.9 10972.2 10992.6 4357.2 4511.0 4589.1 4593.2 4635.4 9373.7 9387.5 9392.6 9394.5 9397.5 5169.0 5174.0 5177.7 5178.9 5180.1 3976.9 4367.4 4396.8 4608.5 4725.9 2933.5 3377.6 3642.9 3762.3 3800.5 1247.1 1250.6 1257.5 1263.6 1268.3 735.5 772.7 789.8 817.7 819.7 5438.6 5443.6 5576.1 5670.5 5707.3 426.8 429.4 431.2 437.8 440.3 3586.5 3736.2 3785.9 3818.7 3849.8 8153.7 10026.3 10070.5 10071.3 10092.7 9915.0 9920.6 9939.8 9947.7 10044.9 7702.2 7754.8 7875.6 7879.4 7891.6 5402.0 5477.4 5543.3 5577.4 5604.2 9296.1 9382.2 9386.3 9387.7 9402.3 9203.3 9355.7 9476.8 9489.0 9589.3 6973.1 7036.9 7038.4 7148.3 7161.6 7734.3 7843.6 7849.4 7860.4 7864.8 6072.3 6757.5 6927.6 6958.8 7133.8 6979.1 6983.5 6984.9 6989.6 7049.1 6464.6 6555.9 6590.0 6630.3 6642.4 4767.9 4803.5 4821.4 4894.8 4982.0 4808.1 4864.8 4895.8 4928.5 4947.3 17:24:23 INFO - PROCESS | 1662 | 17:24:23 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:4272.27 Median:4735.42 stddev:1301.73 (27.5%) stddev-sans-first:1270.81 17:24:23 INFO - PROCESS | 1662 | Values: 301.8 302.4 310.8 316.5 317.4 4790.0 4894.4 5129.3 5142.7 5210.5 4201.8 5037.3 5057.4 5077.3 5095.3 3681.3 3835.2 3840.5 4024.2 4037.3 3283.4 3697.2 3901.8 3949.8 4036.2 3328.9 3898.5 3924.2 3933.2 3938.2 3875.7 3909.8 3914.5 3929.3 3931.9 3125.6 3187.9 3399.5 3407.6 3426.6 3776.6 4402.2 4403.3 5035.8 5042.9 4435.7 4459.4 4478.4 4486.9 4505.0 5040.5 5241.6 5280.4 5397.6 5398.2 3232.8 3423.9 3472.8 3557.2 3776.7 4846.0 5722.3 5761.5 5786.4 5787.9 3388.7 3797.4 3822.8 3837.4 3844.3 3872.6 3885.0 3886.8 3887.6 3899.9 3755.4 4030.2 4463.0 4512.5 4554.8 4671.5 5460.1 5492.0 5499.4 5508.5 1083.9 1168.3 1194.7 1225.0 1226.8 835.6 851.2 855.4 857.3 863.0 4159.7 4222.1 4648.5 4704.9 4729.6 4903.0 5184.9 5248.4 5280.6 5317.4 3995.5 4464.9 4589.6 4716.9 4780.4 2565.4 2744.4 2750.3 2751.7 2765.8 4818.8 4955.1 5349.1 5361.7 5374.2 4741.2 5151.8 5185.0 5191.8 5289.2 4435.9 4797.9 5183.6 5314.7 5325.7 4657.5 4753.8 4799.4 5159.3 5209.5 4092.0 4317.6 4359.5 4785.6 5168.6 4984.0 5006.4 5348.9 5356.6 5364.0 3255.2 3318.0 3528.7 3584.7 3649.2 4517.6 4960.0 5100.0 5131.4 5193.5 4681.9 4896.3 5257.7 5572.4 5579.3 5491.3 5514.2 5520.8 5546.8 5554.3 5210.6 5416.3 5433.0 5498.4 5524.5 5439.3 5458.2 5493.0 5494.9 5517.0 5204.6 5355.6 5360.7 5399.9 5400.4 17:24:23 INFO - PROCESS | 1662 | 17:24:23 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:19287.16 Median:30072.63 stddev:29182.02 (97.0%) stddev-sans-first:29230.09 17:24:23 INFO - PROCESS | 1662 | Values: 582.9 661.9 677.8 705.6 713.4 13472.9 14061.3 14062.7 14079.9 14331.6 12657.1 12748.6 12759.6 12764.2 12779.7 814.9 823.7 825.1 828.7 828.9 822.9 822.9 823.6 824.9 827.3 816.2 854.1 869.1 869.3 873.0 848.3 859.2 862.8 864.4 866.4 645.6 645.7 645.8 646.8 647.7 10848.9 13900.6 13949.2 13970.7 13972.7 10170.6 12122.1 12574.8 13009.0 13072.7 10697.4 10874.6 10897.7 10979.9 10982.6 3521.8 3598.5 3607.3 3667.8 3687.6 92854.5 93023.0 93985.0 95532.0 95945.0 9735.8 9936.8 10176.2 10228.8 10386.7 18799.5 18937.3 19127.9 19168.5 19259.5 7366.6 7475.2 7495.4 7536.7 7619.6 3997.3 4109.2 4148.1 4159.3 4303.5 3177.8 3234.6 3248.2 3289.5 3291.9 605.9 606.0 620.9 625.3 628.1 442.1 596.9 603.8 613.1 613.2 8129.3 8408.0 8533.7 8542.4 8657.3 502.8 517.8 602.1 615.8 619.0 3592.8 3653.4 3864.9 4008.7 4045.6 69213.0 96618.1 109908.1 113887.7 115155.4 64002.4 78284.2 93401.5 94629.0 100822.5 26475.9 59548.4 85517.7 86131.6 87832.0 8103.7 8170.6 8190.7 8240.8 8281.9 40281.4 50891.5 52500.7 55239.4 56142.7 78798.0 79602.4 81734.6 82152.0 83953.6 7687.3 10553.1 10562.1 10572.6 10800.2 11694.5 11725.4 11798.7 12095.6 12259.0 10747.2 11153.4 11183.6 11358.5 11494.3 10748.1 11110.7 11208.9 11518.9 11562.0 9808.1 10740.0 10782.0 10947.8 11107.3 8708.3 9186.8 9210.7 9520.7 9554.4 9316.6 9480.0 9503.9 9604.4 9651.5 17:24:23 INFO - PROCESS | 1662 | -------- Summary: end -------- 17:24:23 INFO - PROCESS | 1662 | 17:24:23 INFO - TEST-INFO | 1662: exit 0 17:24:23 INFO - TEST-OK | dromaeo_css | took 1118801ms 17:24:23 INFO - TEST-START | kraken 17:24:23 INFO - operating with platform_type : mac_ 17:24:23 INFO - Initialising browser for kraken test... 17:24:23 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmpmpVstB/profile http://localhost:49273/getInfo.html) 17:24:26 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 17:24:26 INFO - PROCESS | 1669 | colorDepth:24 17:24:26 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 17:24:26 INFO - PROCESS | 1669 | __metrics 17:24:26 INFO - PROCESS | 1669 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:24:26 INFO - PROCESS | 1669 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:24:27 INFO - TEST-INFO | 1669: exit 0 17:24:27 INFO - Browser initialized. 17:24:27 INFO - Running cycle 1/1 for kraken test... 17:24:27 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmpmpVstB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:24:39 INFO - PROCESS | 1670 | RSS: Main: 241381376 17:24:39 INFO - PROCESS | 1670 | 17:24:41 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 17:24:42 INFO - PROCESS | 1670 | RSS: Main: 291569664 17:24:42 INFO - PROCESS | 1670 | 17:24:45 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 17:24:46 INFO - PROCESS | 1670 | RSS: Main: 294731776 17:24:46 INFO - PROCESS | 1670 | 17:24:49 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 17:24:50 INFO - PROCESS | 1670 | RSS: Main: 383152128 17:24:50 INFO - PROCESS | 1670 | 17:24:52 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 17:24:52 INFO - PROCESS | 1670 | RSS: Main: 284340224 17:24:52 INFO - PROCESS | 1670 | 17:24:54 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:24:55 INFO - PROCESS | 1670 | RSS: Main: 289619968 17:24:55 INFO - PROCESS | 1670 | 17:24:58 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 17:24:59 INFO - PROCESS | 1670 | RSS: Main: 327467008 17:24:59 INFO - PROCESS | 1670 | 17:25:01 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 17:25:02 INFO - PROCESS | 1670 | RSS: Main: 327774208 17:25:02 INFO - PROCESS | 1670 | 17:25:05 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 17:25:05 INFO - PROCESS | 1670 | RSS: Main: 326184960 17:25:05 INFO - PROCESS | 1670 | 17:25:07 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:25:08 INFO - PROCESS | 1670 | RSS: Main: 300027904 17:25:08 INFO - PROCESS | 1670 | 17:25:09 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:25:10 INFO - PROCESS | 1670 | RSS: Main: 305778688 17:25:10 INFO - PROCESS | 1670 | 17:25:12 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:25:13 INFO - PROCESS | 1670 | RSS: Main: 306958336 17:25:13 INFO - PROCESS | 1670 | 17:25:16 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:25:17 INFO - PROCESS | 1670 | RSS: Main: 317870080 17:25:17 INFO - PROCESS | 1670 | 17:25:20 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:25:20 INFO - PROCESS | 1670 | RSS: Main: 318087168 17:25:20 INFO - PROCESS | 1670 | 17:25:22 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 17:25:22 INFO - PROCESS | 1670 | RSS: Main: 361398272 17:25:22 INFO - PROCESS | 1670 | 17:25:22 INFO - PROCESS | 1670 | __start_tp_report 17:25:22 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 17:25:22 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 17:25:22 INFO - PROCESS | 1670 | |i|pagename|runs| 17:25:22 INFO - PROCESS | 1670 | |0;ai-astar;114;113;113;111;112;114;113;111;113;112 17:25:22 INFO - PROCESS | 1670 | |1;audio-beat-detection;154;112;125;154;112;111;112;113;144;130 17:25:22 INFO - PROCESS | 1670 | |2;audio-dft;183;186;184;181;184;189;216;178;180;174 17:25:22 INFO - PROCESS | 1670 | |3;audio-fft;82;82;83;88;79;85;84;60;82;59 17:25:22 INFO - PROCESS | 1670 | |4;audio-oscillator;91;70;92;70;68;68;90;68;71;92 17:25:22 INFO - PROCESS | 1670 | |5;imaging-gaussian-blur;118;130;89;85;87;85;124;84;86;84 17:25:22 INFO - PROCESS | 1670 | |6;imaging-darkroom;93;93;92;93;93;92;92;93;92;92 17:25:22 INFO - PROCESS | 1670 | |7;imaging-desaturate;84;80;80;80;83;82;83;83;87;81 17:25:22 INFO - PROCESS | 1670 | |8;json-parse-financial;56;55;53;52;53;55;54;53;55;55 17:25:22 INFO - PROCESS | 1670 | |9;json-stringify-tinderbox;63;69;69;81;75;71;70;68;68;70 17:25:22 INFO - PROCESS | 1670 | |10;stanford-crypto-aes;87;87;87;85;90;90;85;86;83;86 17:25:22 INFO - PROCESS | 1670 | |11;stanford-crypto-ccm;157;146;150;136;155;161;159;144;188;162 17:25:22 INFO - PROCESS | 1670 | |12;stanford-crypto-pbkdf2;174;170;175;173;174;174;173;171;168;222 17:25:22 INFO - PROCESS | 1670 | |13;stanford-crypto-sha256-iterative;59;85;86;66;67;67;68;64;67;66 17:25:22 INFO - PROCESS | 1670 | __end_tp_report 17:25:22 INFO - PROCESS | 1670 | __start_cc_report 17:25:22 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,1962 17:25:22 INFO - PROCESS | 1670 | __end_cc_report 17:25:22 INFO - PROCESS | 1670 | __startTimestamp1478391922630__endTimestamp 17:25:22 INFO - PROCESS | 1670 | 17:25:22 INFO - PROCESS | 1670 | ------- Summary: start ------- 17:25:22 INFO - PROCESS | 1670 | Number of tests: 14 17:25:22 INFO - PROCESS | 1670 | 17:25:22 INFO - PROCESS | 1670 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:1.07 (1.0%) stddev-sans-first:1.01 17:25:22 INFO - PROCESS | 1670 | Values: 114.0 113.0 113.0 111.0 112.0 114.0 113.0 111.0 113.0 112.0 17:25:22 INFO - PROCESS | 1670 | 17:25:22 INFO - PROCESS | 1670 | [#1] audio-beat-detection Cycles:10 Average:126.70 Median:127.50 stddev:17.91 (14.0%) stddev-sans-first:16.04 17:25:22 INFO - PROCESS | 1670 | Values: 154.0 112.0 125.0 154.0 112.0 111.0 112.0 113.0 144.0 130.0 17:25:22 INFO - PROCESS | 1670 | 17:25:22 INFO - PROCESS | 1670 | [#2] audio-dft Cycles:10 Average:185.50 Median:184.00 stddev:11.51 (6.3%) stddev-sans-first:12.17 17:25:22 INFO - PROCESS | 1670 | Values: 183.0 186.0 184.0 181.0 184.0 189.0 216.0 178.0 180.0 174.0 17:25:22 INFO - PROCESS | 1670 | 17:25:22 INFO - PROCESS | 1670 | [#3] audio-fft Cycles:10 Average:78.40 Median:82.50 stddev:10.23 (12.4%) stddev-sans-first:10.77 17:25:22 INFO - PROCESS | 1670 | Values: 82.0 82.0 83.0 88.0 79.0 85.0 84.0 60.0 82.0 59.0 17:25:22 INFO - PROCESS | 1670 | 17:25:22 INFO - PROCESS | 1670 | [#4] audio-oscillator Cycles:10 Average:78.00 Median:80.50 stddev:11.46 (14.2%) stddev-sans-first:11.15 17:25:22 INFO - PROCESS | 1670 | Values: 91.0 70.0 92.0 70.0 68.0 68.0 90.0 68.0 71.0 92.0 17:25:22 INFO - PROCESS | 1670 | 17:25:22 INFO - PROCESS | 1670 | [#5] imaging-gaussian-blur Cycles:10 Average:97.20 Median:85.00 stddev:18.77 (22.1%) stddev-sans-first:18.33 17:25:22 INFO - PROCESS | 1670 | Values: 118.0 130.0 89.0 85.0 87.0 85.0 124.0 84.0 86.0 84.0 17:25:22 INFO - PROCESS | 1670 | 17:25:22 INFO - PROCESS | 1670 | [#6] imaging-darkroom Cycles:10 Average:92.50 Median:93.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 17:25:22 INFO - PROCESS | 1670 | Values: 93.0 93.0 92.0 93.0 93.0 92.0 92.0 93.0 92.0 92.0 17:25:22 INFO - PROCESS | 1670 | 17:25:22 INFO - PROCESS | 1670 | [#7] imaging-desaturate Cycles:10 Average:82.30 Median:83.00 stddev:2.21 (2.7%) stddev-sans-first:2.26 17:25:22 INFO - PROCESS | 1670 | Values: 84.0 80.0 80.0 80.0 83.0 82.0 83.0 83.0 87.0 81.0 17:25:22 INFO - PROCESS | 1670 | 17:25:22 INFO - PROCESS | 1670 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:55.00 stddev:1.29 (2.3%) stddev-sans-first:1.17 17:25:22 INFO - PROCESS | 1670 | Values: 56.0 55.0 53.0 52.0 53.0 55.0 54.0 53.0 55.0 55.0 17:25:22 INFO - PROCESS | 1670 | 17:25:22 INFO - PROCESS | 1670 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:70.00 stddev:4.77 (6.8%) stddev-sans-first:4.24 17:25:22 INFO - PROCESS | 1670 | Values: 63.0 69.0 69.0 81.0 75.0 71.0 70.0 68.0 68.0 70.0 17:25:22 INFO - PROCESS | 1670 | 17:25:22 INFO - PROCESS | 1670 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:87.00 stddev:2.17 (2.5%) stddev-sans-first:2.30 17:25:22 INFO - PROCESS | 1670 | Values: 87.0 87.0 87.0 85.0 90.0 90.0 85.0 86.0 83.0 86.0 17:25:22 INFO - PROCESS | 1670 | 17:25:22 INFO - PROCESS | 1670 | [#11] stanford-crypto-ccm Cycles:10 Average:155.80 Median:158.00 stddev:14.05 (8.9%) stddev-sans-first:14.89 17:25:22 INFO - PROCESS | 1670 | Values: 157.0 146.0 150.0 136.0 155.0 161.0 159.0 144.0 188.0 162.0 17:25:22 INFO - PROCESS | 1670 | 17:25:22 INFO - PROCESS | 1670 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.40 Median:174.00 stddev:15.82 (9.1%) stddev-sans-first:16.73 17:25:22 INFO - PROCESS | 1670 | Values: 174.0 170.0 175.0 173.0 174.0 174.0 173.0 171.0 168.0 222.0 17:25:22 INFO - PROCESS | 1670 | 17:25:22 INFO - PROCESS | 1670 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:67.00 stddev:8.81 (13.1%) stddev-sans-first:8.49 17:25:22 INFO - PROCESS | 1670 | Values: 59.0 85.0 86.0 66.0 67.0 67.0 68.0 64.0 67.0 66.0 17:25:22 INFO - PROCESS | 1670 | -------- Summary: end -------- 17:25:22 INFO - PROCESS | 1670 | 17:25:23 INFO - TEST-INFO | 1670: exit 0 17:25:23 INFO - TEST-OK | kraken | took 59691ms 17:25:23 INFO - SUITE-END | took 1178s 17:25:23 INFO - Completed test suite (00:19:38) 17:25:23 INFO - javascript benchmark 17:25:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3285.884994025209, 3305.140663427508, 3338.13208565773, 3338.432466480698, 3365.259642878566, 5503.807366742165, 5505.0, 5620.409856965021, 5656.0, 5687.0, 5581.944180558193, 5647.407022262654, 5733.942660573393, 5740.253767010293, 5743.425657434254, 5007.4992500749995, 5064.290999260106, 5111.718855462948, 5154.278401023859, 5162.199859021857, 4522.819087236507, 5202.92195617066, 5245.134552798783, 5247.39654939683, 5299.920501192485, 5018.698878067291, 5182.481751824825, 5196.714180720059, 5201.0, 5277.366715994067, 5073.289739436482, 5125.666831655931, 5133.332666753336, 5135.152699804527, 5142.665726727751, 5025.396952365703, 5081.034603425374, 5102.132637451642, 5118.872028199287, 5122.359705036871, 5582.665040097607, 5612.15817627355, 5616.747246373923, 5620.185073164368, 5622.550195984352, 6069.757209711606, 6072.180255665517, 6080.847978800522, 6083.239595050619, 6085.3914608539235, 6131.988406491147, 6143.569950103494, 6143.911070236097, 6145.139680444741, 6154.76904619078, 5650.63270887391, 5694.601377903548, 5774.2782152230975, 5775.942240577582, 5818.8254352369495, 6206.472449841814, 6213.906791398133, 6255.812325630239, 6279.560430769893, 6281.183446152062, 6082.695865206722, 6097.146399504073, 6109.572329936862, 6111.052786818051, 6120.677614382366, 6029.336772954972, 6115.602485838406, 6116.816495505142, 6126.816195514141, 6157.2611286645, 6167.889779839672, 6181.84545386369, 6182.319944806068, 6182.721777520022, 6186.907196392058, 6175.907361389583, 6199.225096862892, 6207.099970504251, 6214.502839772807, 6230.06549017651, 4779.665423420397, 4846.7818948147415, 4848.127337079289, 4876.975615121902, 4934.55588996992, 4353.934690979638, 4361.869143925687, 4392.824287028547, 4415.072834704748, 4465.285554311295, 5749.9712501437225, 5772.047612144033, 5772.855678608068, 5775.249217601685, 5781.19063331134, 5967.373425790316, 6251.687415629201, 6262.843428914313, 6273.027680709406, 6283.088952102011, 5633.211350410946, 5691.573132015115, 5697.03150464422, 5703.686297253608, 5717.514011309002, 5301.363836339664, 5318.521333079964, 5371.838844834661, 5423.810166644149, 5423.918641220384, 6256.0, 6269.435750782452, 6275.5607107503865, 6284.308726040132, 6293.748250070129, 6251.874962500816, 6276.748930042747, 6302.779402720883, 6309.400606942333, 6318.368163183645, 6203.16257305276, 6229.56393052482, 6259.499240060875, 6269.623822570478, 6277.937220627918, 6115.235595550556, 6144.53915956314, 6145.569810113249, 6151.323354431099, 6159.353267906805, 6173.59871608344, 6226.097215903759, 6240.812775616739, 6254.124422580751, 6260.060990851227, 5822.417758224144, 5882.852928676817, 6023.1868697726995, 6037.366076562073, 6041.728122234422, 5274.736263186748, 5789.465791565154, 5916.526677865674, 5919.733611987384, 5960.970195148997, 5853.678047707417, 5856.12158176277, 5857.326407463196, 5863.882722345615, 5874.823755287348, 4788.066327066189, 5976.193213916065, 6017.909731354121, 6032.245969253843, 6048.697565121638, 5686.289213848269, 5733.5126514245085, 5746.712664366849, 5794.478496935128, 5823.417658234142], "value": 5631.967688039444, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [458.68121655449454, 466.40533320016976, 495.96032317414597, 513.2532165698907, 534.6524758906712, 30381.240468988257, 38274.85175444738, 38939.610603893954, 40388.79805600968, 42483.787581062126, 41549.0, 42049.369259461135, 42107.78946105265, 42139.94650133748, 42271.87057876614, 9229.861552076707, 9382.953085234598, 9412.0, 9412.764680882998, 9418.246540276796, 9289.907100928971, 9381.0, 9397.342186046979, 9397.530123493798, 9407.623695052189, 9311.255099592016, 9357.625694972194, 9369.15677589017, 9378.906210937872, 9382.29632777541, 9334.579943902541, 9359.532023398871, 9360.251179905592, 9364.95317523408, 9372.765680857965, 8003.0, 9359.251259899193, 9365.812683746355, 9379.718608441757, 9382.718518444457, 38978.41532377017, 39389.80305098456, 39435.60564394348, 39450.60549394498, 39547.61583344569, 3385.6275809661165, 3479.0432631026415, 3499.527563778908, 3657.6342365763476, 3734.3278209922205, 29697.851510742308, 29704.554431683326, 30160.396792064035, 30472.695273047208, 31293.0, 3133.9216519586967, 3152.795068320575, 3175.2320019015665, 3232.87068517259, 3261.7390608751243, 470422.6478867618, 473522.0, 473756.0, 473923.6303818493, 474259.0, 57966.710166448895, 58384.99380074418, 58442.0, 58468.415315847145, 58570.70714646485, 33770.83114584412, 34333.14167145841, 34682.65317346845, 61025.69487152536, 61480.07779883305, 15660.0, 15697.607559811097, 15723.764143537855, 15751.606209844846, 15753.369865205263, 10404.427756473315, 12293.385330733428, 12377.876221237853, 12378.257304561756, 12391.442385092692, 18358.908205459153, 18496.982665953234, 18556.164972576265, 18582.907085464485, 18628.906855465637, 6597.703103360361, 7572.6903294495705, 7627.313541781266, 7678.424118191158, 7733.883991740128, 748.3751067858399, 961.6489981156827, 995.7012896131132, 1022.483645758887, 1062.6015244283394, 29150.708492915222, 29335.413291734472, 29413.264668383035, 30229.09312720622, 30336.54495182574, 900.6892622045384, 1000.4347543637822, 1008.4503945349655, 1029.6602121299952, 1052.8473371361263, 14902.70194596102, 15070.397184112731, 15124.319405626773, 15266.847331526764, 15459.227038648023, 664691.0, 667378.0, 668995.0, 669001.0, 670850.0, 56568.0, 56922.0, 56997.715011425506, 57019.42980570224, 57055.42944570584, 1329.8071779591905, 1347.3330701302918, 1359.884409825176, 1362.5707902010836, 1362.6048445950762, 28089.0, 28999.85500072486, 29108.854455727585, 29812.701872980993, 30146.0, 49824.25263620976, 50143.498565013884, 50200.0, 50233.74883125561, 50299.99400011906, 477921.0, 479823.0, 481928.0, 481986.0, 482821.8589070462, 25938.221853343675, 26273.737262627892, 26281.868590656923, 26361.60457593176, 26421.867890660425, 43947.56052439435, 44138.55861441344, 44483.55516444794, 45736.771316143204, 45864.31203532017, 35051.0, 36996.44505332476, 37340.0, 38154.42768358421, 38630.034249142875, 36817.0, 37047.81476092602, 37978.81010594929, 38340.0, 38361.0, 36222.8188859054, 36637.08407289839, 37490.0, 37760.43359349557, 37801.054973625876, 31842.36315273635, 32654.34691306208, 33655.0, 35120.824395877855, 35375.0, 20050.498737531678, 21579.13683452644, 22977.017027549115, 25030.37424064413, 25322.366940826625], "value": 19270.434317821022, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.12816036630073, 369.20989083361627, 375.4555893953767, 384.3984164782117, 404.548927945341, 14276.286185690713, 14558.980871338998, 15618.453354132593, 19551.02244887757, 20112.0, 18960.62078758424, 19365.838049717026, 19644.803551964476, 20024.199032038738, 20247.0, 5760.107183386572, 6057.0, 6062.818115456521, 6072.908906366408, 6078.240219972504, 4178.770167640779, 4417.403650507189, 4545.477270113946, 5980.162777211194, 6060.090986352038, 4420.0938807544535, 6379.776707815227, 6692.732290708366, 6732.249615100085, 6780.355866192704, 6464.870702585969, 6643.368879956396, 6694.2970988046045, 6707.5975441473665, 6761.323867613224, 4955.35580374549, 5725.083986562172, 5802.390748971382, 5812.534997200214, 5815.185873977604, 24410.755892441026, 24637.63043554348, 25173.24480265595, 25174.874125629438, 25359.366015849566, 2114.143771772435, 2145.1955516681246, 2339.63735620979, 2531.923932328771, 2711.8372897626205, 5564.360098588673, 5658.74535645897, 14408.351624176938, 14465.638359041002, 15321.310541025681, 1842.5762074722888, 1843.3363988963963, 1858.9628207435776, 1876.4988009592407, 1898.9870737018666, 110862.0, 110993.44503277513, 114630.0, 114669.0, 117153.0, 11244.887551124548, 11319.377434241196, 11433.885661143448, 11496.94251528737, 11548.0, 14242.643933901529, 14292.642683932776, 14311.928440357731, 14318.785218221736, 14329.0, 7885.29032387088, 8049.959750201211, 8113.148119447373, 8257.669693212205, 8293.95853020731, 6766.458683305324, 7933.761987140395, 8075.313598344206, 8095.352371810359, 8121.837563248702, 3897.240038192582, 4360.912781744348, 4362.563743625612, 4471.396361491222, 4545.704529205591, 1753.587906841891, 1790.2738808360923, 1847.1041544850736, 1935.400025991947, 1945.6886898096236, 772.5712229712564, 785.7721260834294, 941.868138460616, 951.4291425144858, 978.8629591857145, 15468.381264749509, 19389.51526211828, 20370.79629203689, 20390.490237744176, 20479.795202048088, 884.3632584539122, 892.5894088719261, 895.8253140637644, 955.383777463546, 963.9180669643018, 10248.48757562119, 10795.0, 10795.406252656023, 10801.891981080245, 10833.945830270799, 551599.2420037874, 570328.0, 570554.4722763845, 587326.0, 588268.0, 80921.0, 110684.0, 113557.0, 122845.0, 122971.15543266859, 914.5747227539226, 928.5542939389131, 958.5399008475971, 958.7075941837667, 959.1607343574373, 17919.580856584715, 18065.54836129055, 18110.81889181144, 18138.909305453915, 18478.353257635918, 36314.455283170246, 44373.0, 52090.47909520856, 52107.0, 52896.20655690245, 71996.64001679957, 72587.27412725805, 73466.0, 73522.63238683772, 74228.25771742214, 7480.588567628833, 7689.846203076019, 7787.0, 7956.403269754675, 7975.99525487589, 10762.838557421488, 10976.945115274373, 11855.703607409883, 12253.877461225631, 12263.448144833683, 10180.338278011906, 10216.948915255376, 10543.103836174012, 10591.299218699183, 10730.409827459565, 10565.524551395052, 10666.62666806689, 10787.190960678137, 10912.563497460013, 10938.234323597271, 8535.274501667427, 10469.633562825264, 11044.723881903017, 11067.557297708001, 11158.386288754196, 7798.922010779819, 7969.800754981172, 8056.0, 8140.0, 8221.383396245425, 8968.237699795329, 10158.847617285894, 10595.0, 10846.511906964048, 10867.619633312795], "value": 9231.657497176113, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1304.6347022833606, 1446.2045874768874, 1580.6206510437498, 1799.5681036551216, 1834.0829585207389, 8023.117457079724, 8435.70475033374, 8465.111163327854, 8465.19580639839, 8468.703595374156, 6055.697215139247, 7692.3076923076915, 7699.268569485904, 8040.155783642721, 8264.95867520663, 2276.430892276931, 2314.109068008812, 2314.317276403465, 2317.0731707317123, 2321.0483701682315, 2309.6535519672016, 2353.6116540770754, 2361.3624321433203, 2364.467994701187, 2365.7634236576378, 2301.620232661609, 2305.7348404933477, 2332.0088962191085, 2335.995521925571, 2338.8245881558864, 2293.4266433391654, 2301.551197516485, 2320.234322673514, 2324.5118525109665, 2326.348622385735, 2316.293530473205, 2337.235387282608, 2338.4270853640796, 2339.309903578431, 2341.2039906431723, 8351.665933362658, 8411.873821892677, 8420.915790842075, 8429.409941304111, 8462.15378462155, 5028.270900719412, 5192.55863251624, 5192.740362981874, 5196.376434827807, 5205.713685747282, 2856.48583255014, 3156.1320636825058, 3335.7664963452567, 3477.1654802847133, 3481.2863363010524, 1052.3760212853488, 1057.3814318623615, 1085.2240647936685, 1104.690686607751, 1104.9944750276197, 10817.405042722647, 10913.890861091368, 10966.945165274203, 10972.23194376394, 10992.560297588087, 4357.237483440385, 4510.970063471451, 4589.059242855206, 4593.242115051046, 4635.351050852883, 9373.671921482715, 9387.483688397204, 9392.577334019985, 9394.483303418378, 9397.483138427453, 5169.043726910533, 5173.974130129325, 5177.7152256625495, 5178.870528236825, 5180.109260120104, 3976.8608098716404, 4367.410399596078, 4396.824127034947, 4608.470025946992, 4725.881852953635, 2933.515969864991, 3377.611574668895, 3642.927141457156, 3762.2663580602066, 3800.4869342638945, 1247.0833937056439, 1250.5685538489206, 1257.4530079415301, 1263.5577547858177, 1268.315109840694, 735.5366119344885, 772.7334069746041, 789.8459800338994, 817.7260617693021, 819.7049062337554, 5438.646487978269, 5443.591730620219, 5576.10782274834, 5670.489655930986, 5707.315122185364, 426.75461609574, 429.35090491666494, 431.24101581216655, 437.8401883312568, 440.27354864473233, 3586.497890295361, 3736.1593641431004, 3785.930125115512, 3818.656320931074, 3849.7882616455804, 8153.673853045931, 10026.298159128937, 10070.496475176213, 10071.34536255141, 10092.697219083439, 9915.0, 9920.553575088994, 9939.751506212402, 9947.651832185984, 10044.899551004542, 7702.152763195932, 7754.806129846686, 7875.645595948196, 7879.448438609357, 7891.6054197289905, 5401.9736250112355, 5477.370102438112, 5543.307086614173, 5577.386487486292, 5604.159376093618, 9296.116868897443, 9382.249420046244, 9386.342955993015, 9387.718368448684, 9402.2948278878, 9203.263738901005, 9355.672551460939, 9476.810463790824, 9489.0, 9589.328746987643, 6973.12835895513, 7036.859262814817, 7038.40173585251, 7148.320909513588, 7161.641917903979, 7734.26524480196, 7843.647035883513, 7849.411294152847, 7860.410469214946, 7864.84270314602, 6072.301685306246, 6757.526973112032, 6927.618980956096, 6958.79123626292, 7133.82165445868, 6979.092717946634, 6983.546069505669, 6984.930150698428, 6989.615571143432, 7049.08361912948, 6464.5798023128345, 6555.934440655532, 6590.0, 6630.270670226175, 6642.4021838034805, 4767.880802979953, 4803.543663351976, 4821.397325334333, 4894.828680996148, 4982.003599280086, 4808.110499557593, 4864.8054077837905, 4895.779689914034, 4928.457869634266, 4947.282644016669], "value": 4277.8680490423, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.83097465419365, 302.38615610311075, 310.8010873041253, 316.4635942078177, 317.4048658764816, 4789.952100478994, 4894.388201474816, 5129.281900533923, 5142.7371956339275, 5210.505002024806, 4201.831926722935, 5037.319961805155, 5057.367829021372, 5077.339945807049, 5095.261187127864, 3681.2821499807546, 3835.213781174866, 3840.5391353037603, 4024.235395274903, 4037.313656678372, 3283.40898638245, 3697.2235830475634, 3901.8294511646536, 3949.7630142191415, 4036.2129384769983, 3328.900132996014, 3898.5321761388673, 3924.1759230561615, 3933.193695292458, 3938.1926705025544, 3875.6511913927743, 3909.76541407515, 3914.5106861642294, 3929.332013557702, 3931.9410208846602, 3125.64055133658, 3187.856546455415, 3399.538198574612, 3407.5570175877224, 3426.554547908756, 3776.6412190841825, 4402.163588918095, 4403.2954727243805, 5035.798568057273, 5042.865355295066, 4435.7338559686195, 4459.416906998002, 4478.440194975628, 4486.865394038152, 4505.008898042458, 5040.521150490697, 5241.580673546107, 5280.445553216895, 5397.568194544427, 5398.163284690879, 3232.755389175161, 3423.9043506078065, 3472.7742696724886, 3557.239166612543, 3776.6978641708597, 4845.975770121162, 5722.334888460436, 5761.48146666802, 5786.392428794958, 5787.855303617401, 3388.728901687859, 3797.35444974355, 3822.7897465639103, 3837.3860182370686, 3844.2503711775935, 3872.6320999505, 3884.9611503885167, 3886.766793992313, 3887.5723670396233, 3899.863504777319, 3755.3615885299564, 4030.234255491506, 4462.977685111554, 4512.503624601291, 4554.817807287672, 4671.5328467153695, 5460.143551192614, 5492.0, 5499.40517250001, 5508.457631863084, 1083.8619449577911, 1168.3340495917416, 1194.7013246688327, 1224.9632511024683, 1226.8405107335989, 835.5529791561486, 851.2126283188027, 855.3969451536652, 857.3355649371787, 862.9568521573896, 4159.667226621863, 4222.05003874132, 4648.490389755712, 4704.929426058612, 4729.597984171384, 4903.0, 5184.874201577335, 5248.448912864171, 5280.6039547034125, 5317.388500322512, 3995.5005624296964, 4464.86605401832, 4589.567529209524, 4716.88207794801, 4780.354652121919, 2565.4484285878625, 2744.423671029106, 2750.3261700883413, 2751.697313295536, 2765.7510824025935, 4818.783359654598, 4955.058538877602, 5349.144136938071, 5361.651492652965, 5374.211181117303, 4741.241401375763, 5151.793928242903, 5185.033449411203, 5191.779931716043, 5289.20661900718, 4435.911281774411, 4797.928031079537, 5183.611229157828, 5314.734263286898, 5325.700927577085, 4657.487676355666, 4753.809847606057, 4799.448063472745, 5159.251908473176, 5209.53114219722, 4091.97954010228, 4317.589828966243, 4359.455068116486, 4785.569298763128, 5168.638195326442, 4983.975080124721, 5006.374203224597, 5348.866278342917, 5356.5714742821265, 5364.007658583175, 3255.2187475006303, 3318.0377690469495, 3528.6647768461953, 3584.6662603778736, 3649.233660931234, 4517.570830771203, 4960.0, 5100.0, 5131.434912351769, 5193.506616871391, 4681.882952926204, 4896.314515967696, 5257.710825904459, 5572.387037425961, 5579.2746942897165, 5491.341039075336, 5514.24287856072, 5520.779168833202, 5546.805861794818, 5554.305711786027, 5210.557102646318, 5416.2688037114485, 5432.972835135799, 5498.422665620053, 5524.502794748492, 5439.347278326468, 5458.235846981505, 5492.972535137299, 5494.945050549603, 5516.951779161946, 5204.635675502678, 5355.563218735544, 5360.678359298455, 5399.919001215064, 5400.351957764936], "value": 3861.1004018571366, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.8921649494841, 661.8841702702028, 677.7864972533652, 705.6260182103487, 713.3615414204286, 13472.865271347284, 14061.296935153252, 14062.718745625081, 14079.929600351998, 14331.64170895728, 12657.114002019862, 12748.617541473748, 12759.553415630455, 12764.234145951226, 12779.680507987305, 814.9185081491863, 823.6746485138367, 825.1006403020706, 828.6519661742053, 828.8508068547659, 822.8560001999656, 822.8642274024809, 823.6087858267305, 824.9298809601191, 827.2843989948711, 816.2449733996029, 854.0520022774715, 869.0527325215514, 869.3349587565517, 872.9738107856774, 848.3298194426427, 859.1537335724306, 862.784303924019, 864.3992425264444, 866.3978534918234, 645.6223109480959, 645.6771614192903, 645.7675236914707, 646.809191288571, 647.7473785223766, 10848.891511084867, 13900.582982510541, 13949.163050216917, 13970.720585588333, 13972.720545589133, 10170.644027459004, 12122.090843186708, 12574.81137782934, 13009.0, 13072.738545229042, 10697.358158510437, 10874.61938832145, 10897.67306980792, 10979.945100274448, 10982.560697572088, 3521.7710848794745, 3598.514200582914, 3607.313866077868, 3667.8166091695575, 3687.612800655946, 92854.53572732094, 93023.0, 93985.0, 95532.0, 95945.0, 9735.756606084904, 9936.801263974825, 10176.236782241214, 10228.846567301496, 10386.740331491623, 18799.530011749543, 18937.33719319817, 19127.904360478387, 19168.520786980436, 19259.51851203731, 7366.558006519626, 7475.215102414277, 7495.400367970549, 7536.660850261642, 7619.580923049286, 3997.2804895119157, 4109.239790638741, 4148.087420767487, 4159.251334759772, 4303.526612072669, 3177.7934434261697, 3234.6280177779386, 3248.1717162123978, 3289.5394644749754, 3291.9341613167603, 605.866709323948, 605.975760969565, 620.8882401167742, 625.3215261441387, 628.133176216827, 442.10032583692674, 596.8537708261417, 603.8399824046631, 613.123233775705, 613.1599708399522, 8129.349652027823, 8407.95796021016, 8533.74398768038, 8542.402031857835, 8657.307415406753, 502.8491452564216, 517.7928828468642, 602.1389413139166, 615.8398816307703, 618.9690515474208, 3592.8023958682, 3653.397189463709, 3864.903377415531, 4008.677136544933, 4045.615666511677, 69213.0, 96618.06763864684, 109908.054137564, 113887.72224555463, 115155.42422288003, 64002.35997639964, 78284.21715782883, 93401.5329923346, 94629.0, 100822.4958875201, 26475.86762066216, 59548.40451595515, 85517.71723424029, 86131.56934215414, 87832.0, 8103.6758529658155, 8170.632321545663, 8190.672373105247, 8240.793980150544, 8281.917180828115, 40281.395779062754, 50891.49108508867, 52500.7374963138, 55239.44760552343, 56142.719286403306, 78798.0, 79602.40795183949, 81734.59132704299, 82152.0, 83953.58023209845, 7687.346575541142, 10553.050225479743, 10562.102221311274, 10572.629957951434, 10800.189985750943, 11694.532218711156, 11725.41372931367, 11798.705032374259, 12095.57665481704, 12259.0, 10747.247692661438, 11153.442327883411, 11183.552657893593, 11358.488868001125, 11494.252873563191, 10748.086412655011, 11110.722231944266, 11208.887911120784, 11518.884811152117, 11562.0, 9808.117269445784, 10740.033396994308, 10782.0, 10947.781044378908, 11107.333559986426, 8708.28152200945, 9186.770330741785, 9210.723678289662, 9520.714378568655, 9554.378965367228, 9316.627334906529, 9480.0, 9503.892992613406, 9604.375715578464, 9651.517424128626], "value": 6784.8142517411425, "unit": "score"}], "name": "dromaeo_css", "value": 6945.863107497164, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 111.0, 112.0, 114.0, 113.0, 111.0, 113.0, 112.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 112.0, 125.0, 154.0, 112.0, 111.0, 112.0, 113.0, 144.0, 130.0], "value": 126.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 186.0, 184.0, 181.0, 184.0, 189.0, 216.0, 178.0, 180.0, 174.0], "value": 185.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 83.0, 88.0, 79.0, 85.0, 84.0, 60.0, 82.0, 59.0], "value": 78.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 70.0, 92.0, 70.0, 68.0, 68.0, 90.0, 68.0, 71.0, 92.0], "value": 78.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 130.0, 89.0, 85.0, 87.0, 85.0, 124.0, 84.0, 86.0, 84.0], "value": 97.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 92.0, 93.0, 93.0, 92.0, 92.0, 93.0, 92.0, 92.0], "value": 92.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 80.0, 80.0, 83.0, 82.0, 83.0, 83.0, 87.0, 81.0], "value": 82.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 53.0, 52.0, 53.0, 55.0, 54.0, 53.0, 55.0, 55.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 69.0, 69.0, 81.0, 75.0, 71.0, 70.0, 68.0, 68.0, 70.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 87.0, 85.0, 90.0, 90.0, 85.0, 86.0, 83.0, 86.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 146.0, 150.0, 136.0, 155.0, 161.0, 159.0, 144.0, 188.0, 162.0], "value": 155.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 170.0, 175.0, 173.0, 174.0, 174.0, 173.0, 171.0, 168.0, 222.0], "value": 177.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 85.0, 86.0, 66.0, 67.0, 67.0, 68.0, 64.0, 67.0, 66.0], "value": 69.5, "unit": "score"}], "name": "kraken", "value": 1467.0, "alertThreshold": 2.0}]} 17:25:23 INFO - Return code: 0 17:25:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:25:23 INFO - # TBPL SUCCESS # 17:25:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:25:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:25:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:25:23 INFO - 2016-11-05 17:25:23.945 screenresolution[1674:10349] starting screenresolution argv=screenresolution get 17:25:23 INFO - 2016-11-05 17:25:23.949 screenresolution[1674:10349] Display 0: 1600x1200x32@60 17:25:23 INFO - 2016-11-05 17:25:23.956 screenresolution[1675:10352] starting screenresolution argv=screenresolution list 17:25:23 INFO - Available Modes on Display 0 17:25:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:25:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:25:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:25:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:25:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:25:24 INFO - Intel Iris: 17:25:24 INFO - Chipset Model: Intel Iris 17:25:24 INFO - Type: GPU 17:25:24 INFO - Bus: Built-In 17:25:24 INFO - VRAM (Dynamic, Max): 1536 MB 17:25:24 INFO - Vendor: Intel (0x8086) 17:25:24 INFO - Device ID: 0x0a2e 17:25:24 INFO - Revision ID: 0x0009 17:25:24 INFO - Displays: 17:25:24 INFO - Display: 17:25:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:25:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:25:24 INFO - Display Serial Number: 1600x1200 60 17:25:24 INFO - Main Display: Yes 17:25:24 INFO - Mirror: Off 17:25:24 INFO - Online: Yes 17:25:24 INFO - Rotation: Supported 17:25:24 INFO - Return code: 0 17:25:24 INFO - Running post-action listener: _resource_record_post_action 17:25:24 INFO - [mozharness: 2016-11-06 00:25:24.193786Z] Finished run-tests step (success) 17:25:24 INFO - Running post-run listener: _resource_record_post_run 17:25:24 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 33238016; Write bytes: 704992768; Read time: 351; Write time: 2046 17:25:24 INFO - TinderboxPrint: CPU usage
53.7% 17:25:24 INFO - TinderboxPrint: I/O read bytes / time
33,238,016 / 351 17:25:24 INFO - TinderboxPrint: I/O write bytes / time
704,992,768 / 2,046 17:25:24 INFO - TinderboxPrint: CPU idle
2,244.8 (46.3%) 17:25:24 INFO - TinderboxPrint: CPU system
972.5 (20.0%) 17:25:24 INFO - TinderboxPrint: CPU user
1,636.3 (33.7%) 17:25:24 INFO - TinderboxPrint: Swap in / out
432,603,136 / 0 17:25:24 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 398737920; Write bytes: 392755200; Read time: 29600; Write time: 719 17:25:24 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 31165440; Write bytes: 297917952; Read time: 329; Write time: 1287 17:25:24 INFO - Running post-run listener: _upload_blobber_files 17:25:24 INFO - Blob upload gear active. 17:25:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:25:24 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 17:25:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Larch', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:25:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Larch -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:25:25 INFO - (blobuploader) - INFO - Open directory for files ... 17:25:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:25:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:25:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:25:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:25:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:25:26 INFO - (blobuploader) - INFO - Done attempting. 17:25:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:25:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:25:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:25:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:25:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:25:27 INFO - (blobuploader) - INFO - Done attempting. 17:25:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:25:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:25:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:25:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:25:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:25:30 INFO - (blobuploader) - INFO - Done attempting. 17:25:30 INFO - (blobuploader) - INFO - Iteration through files over. 17:25:30 INFO - Return code: 0 17:25:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:25:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:25:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/878b43e543db0f1a1ebac99b3200e02bdc0683bf048efefc5f09d065b031cccb5d0b95e2039cea7937993529dcd036b2d3b4d1c42ca70c9b80684954faa3e3b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/6d3a878e211c24c09e01f56c243d0698f3972a5894acdf0fc1b78727b137e0127b49c7b73b4bd46848b16b21cd1f7fdb3cc2a243f76c6a87161baf6c212b9c79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/c31ac16190add6839c5907e862eaf729801ce9e004cf0a821dc60b344e0a9a7f519bfe27492d81ff57f735b9c73f25c65c599dbf64d645d130b8e1c0e4e60924"} 17:25:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:25:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:25:30 INFO - Contents: 17:25:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/878b43e543db0f1a1ebac99b3200e02bdc0683bf048efefc5f09d065b031cccb5d0b95e2039cea7937993529dcd036b2d3b4d1c42ca70c9b80684954faa3e3b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/6d3a878e211c24c09e01f56c243d0698f3972a5894acdf0fc1b78727b137e0127b49c7b73b4bd46848b16b21cd1f7fdb3cc2a243f76c6a87161baf6c212b9c79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/c31ac16190add6839c5907e862eaf729801ce9e004cf0a821dc60b344e0a9a7f519bfe27492d81ff57f735b9c73f25c65c599dbf64d645d130b8e1c0e4e60924"} 17:25:30 INFO - Running post-run listener: copy_logs_to_upload_dir 17:25:30 INFO - Copying logs to upload dir... 17:25:30 INFO - mkdir: /builds/slave/test/build/upload/logs 17:25:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.902413 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-11-05 17:25:30.182085) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-05 17:25:30.185355) ========= 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.Esp7xnFhCd/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.AecIwXk4i5/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/878b43e543db0f1a1ebac99b3200e02bdc0683bf048efefc5f09d065b031cccb5d0b95e2039cea7937993529dcd036b2d3b4d1c42ca70c9b80684954faa3e3b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/6d3a878e211c24c09e01f56c243d0698f3972a5894acdf0fc1b78727b137e0127b49c7b73b4bd46848b16b21cd1f7fdb3cc2a243f76c6a87161baf6c212b9c79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/c31ac16190add6839c5907e862eaf729801ce9e004cf0a821dc60b344e0a9a7f519bfe27492d81ff57f735b9c73f25c65c599dbf64d645d130b8e1c0e4e60924"} build_url:https://queue.taskcluster.net/v1/task/TjvhzVnfQuqS64A_Z0tXhA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011362 build_url: 'https://queue.taskcluster.net/v1/task/TjvhzVnfQuqS64A_Z0tXhA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/878b43e543db0f1a1ebac99b3200e02bdc0683bf048efefc5f09d065b031cccb5d0b95e2039cea7937993529dcd036b2d3b4d1c42ca70c9b80684954faa3e3b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/6d3a878e211c24c09e01f56c243d0698f3972a5894acdf0fc1b78727b137e0127b49c7b73b4bd46848b16b21cd1f7fdb3cc2a243f76c6a87161baf6c212b9c79", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/c31ac16190add6839c5907e862eaf729801ce9e004cf0a821dc60b344e0a9a7f519bfe27492d81ff57f735b9c73f25c65c599dbf64d645d130b8e1c0e4e60924"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-05 17:25:30.218507) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 17:25:30.218903) ========= 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.Esp7xnFhCd/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.AecIwXk4i5/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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.005357 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 17:25:30.267637) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-05 17:25:30.268017) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-05 17:25:30.268360) ========= ========= Total master_lag: 0.25 =========