builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0316 starttime: 1477753158.52 results: success (0) buildid: 20161029061621 builduid: 92d01bc6cb6346fbaef34f023c4edfad revision: 2d10bed515455ac26b84f225feae8785ea3e600b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-29 07:59:18.518049) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-29 07:59:18.518516) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-29 07:59:18.518793) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-29 07:59:18.542297) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 07:59:18.542696) ========= 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.SNzcGVdkLA/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.qcXlKpWcMc/Listeners TMPDIR=/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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-10-29 07:59:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 149M=0s 2016-10-29 07:59:18 (149 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129770 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 07:59:18.694867) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 07:59:18.695177) ========= 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.SNzcGVdkLA/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.qcXlKpWcMc/Listeners TMPDIR=/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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.019172 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 07:59:18.744206) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-29 07:59:18.744574) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2d10bed515455ac26b84f225feae8785ea3e600b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2d10bed515455ac26b84f225feae8785ea3e600b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SNzcGVdkLA/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.qcXlKpWcMc/Listeners TMPDIR=/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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-10-29 07:59:18,827 truncating revision to first 12 chars 2016-10-29 07:59:18,827 Setting DEBUG logging. 2016-10-29 07:59:18,827 attempt 1/10 2016-10-29 07:59:18,827 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2d10bed51545?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-29 07:59:20,149 unpacking tar archive at: mozilla-aurora-2d10bed51545/testing/mozharness/ program finished with exit code 0 elapsedTime=1.606194 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-29 07:59:20.373557) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-29 07:59:20.373898) ========= script_repo_revision: 2d10bed515455ac26b84f225feae8785ea3e600b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-29 07:59:20.374385) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-29 07:59:20.374793) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-29 07:59:20.393847) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-10-29 07:59:20.394182) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SNzcGVdkLA/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.qcXlKpWcMc/Listeners TMPDIR=/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 07:59:20 INFO - MultiFileLogger online at 20161029 07:59:20 in /builds/slave/test 07:59:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:59:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:59:20 INFO - {'append_to_log': False, 07:59:20 INFO - 'base_work_dir': '/builds/slave/test', 07:59:20 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:59:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:59:20 INFO - 'branch': 'Mozilla-Aurora', 07:59:20 INFO - 'buildbot_json_path': 'buildprops.json', 07:59:20 INFO - 'config_files': ('talos/mac_config.py',), 07:59:20 INFO - 'default_actions': ('clobber', 07:59:20 INFO - 'read-buildbot-config', 07:59:20 INFO - 'download-and-extract', 07:59:20 INFO - 'populate-webroot', 07:59:20 INFO - 'create-virtualenv', 07:59:20 INFO - 'install', 07:59:20 INFO - 'run-tests'), 07:59:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:59:20 INFO - 'download_minidump_stackwalk': True, 07:59:20 INFO - 'download_symbols': 'ondemand', 07:59:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:59:20 INFO - 'tooltool.py': '/tools/tooltool.py', 07:59:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:59:20 INFO - '/tools/misc-python/virtualenv.py')}, 07:59:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:59:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:59:20 INFO - 'installer_path': 'installer.exe', 07:59:20 INFO - 'log_level': 'info', 07:59:20 INFO - 'log_name': 'talos', 07:59:20 INFO - 'log_to_console': True, 07:59:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:59:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:59:20 INFO - 'opt_config_files': (), 07:59:20 INFO - 'pip_index': False, 07:59:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:59:20 INFO - 'cmd': ('bash', 07:59:20 INFO - '-c', 07:59:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:59:20 INFO - 'enabled': True, 07:59:20 INFO - 'halt_on_failure': False, 07:59:20 INFO - 'name': 'check_screen_resolution'},), 07:59:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:59:20 INFO - 'cmd': ('bash', 07:59:20 INFO - '-c', 07:59:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:59:20 INFO - 'enabled': True, 07:59:20 INFO - 'halt_on_failure': False, 07:59:20 INFO - 'name': 'check_screen_resolution'},), 07:59:20 INFO - 'run_cmd_checks_enabled': True, 07:59:20 INFO - 'sps_profile': False, 07:59:20 INFO - 'sps_profile_interval': 0, 07:59:20 INFO - 'suite': 'dromaeojs', 07:59:20 INFO - 'system_bits': '32', 07:59:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:59:20 INFO - 'title': 't-yosemite-r7-0316', 07:59:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:59:20 INFO - 'use_talos_json': True, 07:59:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:59:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:59:20 INFO - 'work_dir': 'build'} 07:59:20 INFO - [mozharness: 2016-10-29 14:59:20.591948Z] Running clobber step. 07:59:20 INFO - Running pre-action listener: _resource_record_pre_action 07:59:20 INFO - Running main action method: clobber 07:59:20 INFO - rmtree: /builds/slave/test/build 07:59:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:59:22 INFO - Running post-action listener: _resource_record_post_action 07:59:22 INFO - [mozharness: 2016-10-29 14:59:22.128570Z] Finished clobber step (success) 07:59:22 INFO - [mozharness: 2016-10-29 14:59:22.128703Z] Running read-buildbot-config step. 07:59:22 INFO - Running pre-action listener: _resource_record_pre_action 07:59:22 INFO - Running main action method: read_buildbot_config 07:59:22 INFO - Using buildbot properties: 07:59:22 INFO - { 07:59:22 INFO - "project": "", 07:59:22 INFO - "product": "firefox", 07:59:22 INFO - "script_repo_revision": "production", 07:59:22 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 07:59:22 INFO - "repository": "", 07:59:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 07:59:22 INFO - "buildid": "20161029061621", 07:59:22 INFO - "pgo_build": "False", 07:59:22 INFO - "basedir": "/builds/slave/test", 07:59:22 INFO - "buildnumber": 10, 07:59:22 INFO - "slavename": "t-yosemite-r7-0316", 07:59:22 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 07:59:22 INFO - "platform": "yosemite_r7", 07:59:22 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:59:22 INFO - "branch": "mozilla-aurora", 07:59:22 INFO - "repo_path": "releases/mozilla-aurora", 07:59:22 INFO - "revision": "2d10bed515455ac26b84f225feae8785ea3e600b", 07:59:22 INFO - "stage_platform": "macosx64", 07:59:22 INFO - "builduid": "92d01bc6cb6346fbaef34f023c4edfad", 07:59:22 INFO - "slavebuilddir": "test" 07:59:22 INFO - } 07:59:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/N673DChmTh6paGnkX3YjOw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 07:59:22 INFO - Running post-action listener: _resource_record_post_action 07:59:22 INFO - [mozharness: 2016-10-29 14:59:22.132151Z] Finished read-buildbot-config step (success) 07:59:22 INFO - [mozharness: 2016-10-29 14:59:22.132297Z] Running download-and-extract step. 07:59:22 INFO - Running pre-action listener: _resource_record_pre_action 07:59:22 INFO - Running main action method: download_and_extract 07:59:22 INFO - mkdir: /builds/slave/test/build/tests 07:59:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:22 INFO - trying https://queue.taskcluster.net/v1/task/N673DChmTh6paGnkX3YjOw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 07:59:22 INFO - Downloading https://queue.taskcluster.net/v1/task/N673DChmTh6paGnkX3YjOw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 07:59:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N673DChmTh6paGnkX3YjOw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 07:59:23 INFO - Downloaded 1199 bytes. 07:59:23 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 07:59:23 INFO - Using the following test package requirements: 07:59:23 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 07:59:23 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:59:23 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 07:59:23 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:59:23 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 07:59:23 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:59:23 INFO - u'jsshell-mac.zip'], 07:59:23 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:59:23 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 07:59:23 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 07:59:23 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:59:23 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 07:59:23 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:59:23 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 07:59:23 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:59:23 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 07:59:23 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:59:23 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 07:59:23 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:59:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N673DChmTh6paGnkX3YjOw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 07:59:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N673DChmTh6paGnkX3YjOw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:59:23 INFO - Fetch https://queue.taskcluster.net/v1/task/N673DChmTh6paGnkX3YjOw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 07:59:23 INFO - Expected file size: 16420920 07:59:30 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 07:59:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N673DChmTh6paGnkX3YjOw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 07:59:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N673DChmTh6paGnkX3YjOw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:59:30 INFO - Fetch https://queue.taskcluster.net/v1/task/N673DChmTh6paGnkX3YjOw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 07:59:31 INFO - Expected file size: 16420920 07:59:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N673DChmTh6paGnkX3YjOw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 07:59:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N673DChmTh6paGnkX3YjOw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:59:37 INFO - Fetch https://queue.taskcluster.net/v1/task/N673DChmTh6paGnkX3YjOw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 07:59:38 INFO - Expected file size: 14414081 07:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:38 INFO - trying https://queue.taskcluster.net/v1/task/N673DChmTh6paGnkX3YjOw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:59:38 INFO - Downloading https://queue.taskcluster.net/v1/task/N673DChmTh6paGnkX3YjOw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 07:59:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N673DChmTh6paGnkX3YjOw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 07:59:41 INFO - Downloaded 115418472 bytes. 07:59:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N673DChmTh6paGnkX3YjOw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:59:41 INFO - mkdir: /builds/slave/test/properties 07:59:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:59:41 INFO - Writing to file /builds/slave/test/properties/build_url 07:59:41 INFO - Contents: 07:59:41 INFO - build_url:https://queue.taskcluster.net/v1/task/N673DChmTh6paGnkX3YjOw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:59:42 INFO - Running post-action listener: _resource_record_post_action 07:59:42 INFO - Running post-action listener: set_extra_try_arguments 07:59:42 INFO - [mozharness: 2016-10-29 14:59:42.417188Z] Finished download-and-extract step (success) 07:59:42 INFO - [mozharness: 2016-10-29 14:59:42.417285Z] Running populate-webroot step. 07:59:42 INFO - Running pre-action listener: _resource_record_pre_action 07:59:42 INFO - Running main action method: populate_webroot 07:59:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:59:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:59:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:59:42 INFO - '--tppagecycles', 07:59:42 INFO - '7'], 07:59:42 INFO - 'tests': ['tsvgm']}}, 07:59:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:59:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:59:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:59:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:59:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:59:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:59:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:42 INFO - 'talos_options': ['--disable-e10s'], 07:59:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:59:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:59:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:42 INFO - 'talos_options': ['--disable-e10s'], 07:59:42 INFO - 'tests': ['damp', 'tps']}, 07:59:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:42 INFO - 'tests': ['damp', 'tps']}, 07:59:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:59:42 INFO - 'tests': ['dromaeo_dom']}, 07:59:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:59:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:59:42 INFO - 'tests': ['basic_compositor_video']}, 07:59:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:59:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:59:42 INFO - 'tests': ['a11yr', 07:59:42 INFO - 'ts_paint', 07:59:42 INFO - 'tpaint', 07:59:42 INFO - 'sessionrestore', 07:59:42 INFO - 'sessionrestore_no_auto_restore', 07:59:42 INFO - 'tabpaint']}, 07:59:42 INFO - 'other-e10s': {'tests': ['a11yr', 07:59:42 INFO - 'ts_paint', 07:59:42 INFO - 'tpaint', 07:59:42 INFO - 'sessionrestore', 07:59:42 INFO - 'sessionrestore_no_auto_restore', 07:59:42 INFO - 'tabpaint']}, 07:59:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:59:42 INFO - 'ts_paint', 07:59:42 INFO - 'tpaint', 07:59:42 INFO - 'sessionrestore', 07:59:42 INFO - 'sessionrestore_no_auto_restore', 07:59:42 INFO - 'tabpaint']}, 07:59:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:59:42 INFO - 'ts_paint', 07:59:42 INFO - 'tpaint', 07:59:42 INFO - 'sessionrestore', 07:59:42 INFO - 'sessionrestore_no_auto_restore', 07:59:42 INFO - 'tabpaint']}, 07:59:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:59:42 INFO - 'tests': ['a11yr', 07:59:42 INFO - 'ts_paint', 07:59:42 INFO - 'tpaint', 07:59:42 INFO - 'sessionrestore', 07:59:42 INFO - 'sessionrestore_no_auto_restore', 07:59:42 INFO - 'tabpaint']}, 07:59:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:59:42 INFO - 'tests': ['a11yr', 07:59:42 INFO - 'ts_paint', 07:59:42 INFO - 'tpaint', 07:59:42 INFO - 'sessionrestore', 07:59:42 INFO - 'sessionrestore_no_auto_restore', 07:59:42 INFO - 'tabpaint']}, 07:59:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:59:42 INFO - 'tests': ['tsvgx', 07:59:42 INFO - 'tsvgr_opacity', 07:59:42 INFO - 'tart', 07:59:42 INFO - 'tscrollx', 07:59:42 INFO - 'cart']}, 07:59:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:59:42 INFO - 'tsvgr_opacity', 07:59:42 INFO - 'tart', 07:59:42 INFO - 'tscrollx', 07:59:42 INFO - 'cart']}, 07:59:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:42 INFO - 'talos_options': ['--disable-e10s'], 07:59:42 INFO - 'tests': ['tp5o']}, 07:59:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:42 INFO - 'tests': ['tp5o']}, 07:59:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:42 INFO - 'talos_options': ['--disable-e10s', 07:59:42 INFO - '--xperf_path', 07:59:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:59:42 INFO - 'tests': ['tp5n']}, 07:59:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:42 INFO - 'talos_options': ['--xperf_path', 07:59:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:59:42 INFO - 'tests': ['tp5n']}}, 07:59:42 INFO - 'talos.zip': {'path': '', 07:59:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:59:42 INFO - Running post-action listener: _resource_record_post_action 07:59:42 INFO - [mozharness: 2016-10-29 14:59:42.436009Z] Finished populate-webroot step (success) 07:59:42 INFO - [mozharness: 2016-10-29 14:59:42.436145Z] Running create-virtualenv step. 07:59:42 INFO - Running pre-action listener: _resource_record_pre_action 07:59:42 INFO - Running main action method: create_virtualenv 07:59:42 INFO - Creating virtualenv /builds/slave/test/build/venv 07:59:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:59:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:59:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:59:42 INFO - Using real prefix '/tools/python27' 07:59:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:59:43 INFO - Installing distribute.............................................................................................................................................................................................done. 07:59:46 INFO - Installing pip.................done. 07:59:46 INFO - Return code: 0 07:59:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106285490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061fb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7615790d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106099d30>, '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 0x105effdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106091b20>, '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.SNzcGVdkLA/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.qcXlKpWcMc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:59:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:59:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:59:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SNzcGVdkLA/Render', 07:59:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:46 INFO - 'HOME': '/Users/cltbld', 07:59:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:46 INFO - 'LOGNAME': 'cltbld', 07:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:46 INFO - 'MOZ_NO_REMOTE': '1', 07:59:46 INFO - 'NO_EM_RESTART': '1', 07:59:46 INFO - 'PAGER': '/bin/cat', 07:59:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:46 INFO - 'PWD': '/builds/slave/test', 07:59:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:46 INFO - 'SHELL': '/bin/bash', 07:59:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qcXlKpWcMc/Listeners', 07:59:46 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 07:59:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:46 INFO - 'USER': 'cltbld', 07:59:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:46 INFO - 'XPC_FLAGS': '0x0', 07:59:46 INFO - 'XPC_SERVICE_NAME': '0', 07:59:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:59:46 INFO - Cleaning up... 07:59:46 INFO - Return code: 0 07:59:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106285490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061fb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7615790d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106099d30>, '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 0x105effdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106091b20>, '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.SNzcGVdkLA/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.qcXlKpWcMc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:59:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:59:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:59:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SNzcGVdkLA/Render', 07:59:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:46 INFO - 'HOME': '/Users/cltbld', 07:59:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:46 INFO - 'LOGNAME': 'cltbld', 07:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:46 INFO - 'MOZ_NO_REMOTE': '1', 07:59:46 INFO - 'NO_EM_RESTART': '1', 07:59:46 INFO - 'PAGER': '/bin/cat', 07:59:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:46 INFO - 'PWD': '/builds/slave/test', 07:59:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:46 INFO - 'SHELL': '/bin/bash', 07:59:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qcXlKpWcMc/Listeners', 07:59:46 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 07:59:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:46 INFO - 'USER': 'cltbld', 07:59:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:46 INFO - 'XPC_FLAGS': '0x0', 07:59:46 INFO - 'XPC_SERVICE_NAME': '0', 07:59:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:46 INFO - Downloading/unpacking psutil>=3.1.1 07:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:59:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:59:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:59:50 INFO - Installing collected packages: psutil 07:59:50 INFO - Running setup.py install for psutil 07:59:50 INFO - building 'psutil._psutil_osx' extension 07:59:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:59:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:59:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:59:50 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:59:50 INFO - building 'psutil._psutil_posix' extension 07:59:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:59:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:59:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:59:50 INFO - ^ 07:59:50 INFO - 1 warning generated. 07:59:50 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:59:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:59:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:59:50 INFO - Successfully installed psutil 07:59:50 INFO - Cleaning up... 07:59:50 INFO - Return code: 0 07:59:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:59: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')]} 07:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59: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')]} 07:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106285490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061fb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7615790d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106099d30>, '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 0x105effdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106091b20>, '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.SNzcGVdkLA/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.qcXlKpWcMc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:59: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:59: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 mozsystemmonitor==0.3 07:59:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SNzcGVdkLA/Render', 07:59:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:50 INFO - 'HOME': '/Users/cltbld', 07:59:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:50 INFO - 'LOGNAME': 'cltbld', 07:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:50 INFO - 'MOZ_NO_REMOTE': '1', 07:59:50 INFO - 'NO_EM_RESTART': '1', 07:59:50 INFO - 'PAGER': '/bin/cat', 07:59:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:50 INFO - 'PWD': '/builds/slave/test', 07:59:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:50 INFO - 'SHELL': '/bin/bash', 07:59:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qcXlKpWcMc/Listeners', 07:59:50 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 07:59:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:50 INFO - 'USER': 'cltbld', 07:59:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:50 INFO - 'XPC_FLAGS': '0x0', 07:59:50 INFO - 'XPC_SERVICE_NAME': '0', 07:59:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:59:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:59:53 INFO - Installing collected packages: mozsystemmonitor 07:59:53 INFO - Running setup.py install for mozsystemmonitor 07:59:53 INFO - Successfully installed mozsystemmonitor 07:59:53 INFO - Cleaning up... 07:59:54 INFO - Return code: 0 07:59:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:59: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')]} 07:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59: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')]} 07:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59: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', '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 0x106285490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061fb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7615790d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106099d30>, '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 0x105effdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106091b20>, '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.SNzcGVdkLA/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.qcXlKpWcMc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:59: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:59: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 jsonschema==2.5.1 07:59:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SNzcGVdkLA/Render', 07:59:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:54 INFO - 'HOME': '/Users/cltbld', 07:59:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:54 INFO - 'LOGNAME': 'cltbld', 07:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:54 INFO - 'MOZ_NO_REMOTE': '1', 07:59:54 INFO - 'NO_EM_RESTART': '1', 07:59:54 INFO - 'PAGER': '/bin/cat', 07:59:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:54 INFO - 'PWD': '/builds/slave/test', 07:59:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:54 INFO - 'SHELL': '/bin/bash', 07:59:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qcXlKpWcMc/Listeners', 07:59:54 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 07:59:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:54 INFO - 'USER': 'cltbld', 07:59:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:54 INFO - 'XPC_FLAGS': '0x0', 07:59:54 INFO - 'XPC_SERVICE_NAME': '0', 07:59:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:54 INFO - Downloading/unpacking jsonschema==2.5.1 07:59: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 07:59: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 07:59: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 07:59: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 07:59: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 07:59: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 07:59:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:59:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:57 INFO - Downloading functools32-3.2.3-2.tar.gz 07:59:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:59:57 INFO - warning: no files found matching '*.txt' 07:59:57 INFO - no previously-included directories found matching 'build' 07:59:57 INFO - no previously-included directories found matching 'dist' 07:59:57 INFO - no previously-included directories found matching '.git*' 07:59:57 INFO - Installing collected packages: jsonschema, functools32 07:59:57 INFO - Running setup.py install for functools32 07:59:57 INFO - warning: no files found matching '*.txt' 07:59:57 INFO - no previously-included directories found matching 'build' 07:59:57 INFO - no previously-included directories found matching 'dist' 07:59:57 INFO - no previously-included directories found matching '.git*' 07:59:57 INFO - Successfully installed jsonschema functools32 07:59:57 INFO - Cleaning up... 07:59:57 INFO - Return code: 0 07:59:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:57 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 0x106285490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061fb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7615790d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106099d30>, '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 0x105effdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106091b20>, '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.SNzcGVdkLA/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.qcXlKpWcMc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:59:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:59:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:59:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SNzcGVdkLA/Render', 07:59:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:57 INFO - 'HOME': '/Users/cltbld', 07:59:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:57 INFO - 'LOGNAME': 'cltbld', 07:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:57 INFO - 'MOZ_NO_REMOTE': '1', 07:59:57 INFO - 'NO_EM_RESTART': '1', 07:59:57 INFO - 'PAGER': '/bin/cat', 07:59:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:57 INFO - 'PWD': '/builds/slave/test', 07:59:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:57 INFO - 'SHELL': '/bin/bash', 07:59:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qcXlKpWcMc/Listeners', 07:59:57 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 07:59:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:57 INFO - 'USER': 'cltbld', 07:59:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:57 INFO - 'XPC_FLAGS': '0x0', 07:59:57 INFO - 'XPC_SERVICE_NAME': '0', 07:59:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:59:57 INFO - Cleaning up... 07:59:57 INFO - Return code: 0 07:59:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:57 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 0x106285490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061fb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7615790d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106099d30>, '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 0x105effdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106091b20>, '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.SNzcGVdkLA/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.qcXlKpWcMc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:59:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:59:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:59:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SNzcGVdkLA/Render', 07:59:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:57 INFO - 'HOME': '/Users/cltbld', 07:59:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:57 INFO - 'LOGNAME': 'cltbld', 07:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:57 INFO - 'MOZ_NO_REMOTE': '1', 07:59:57 INFO - 'NO_EM_RESTART': '1', 07:59:57 INFO - 'PAGER': '/bin/cat', 07:59:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:57 INFO - 'PWD': '/builds/slave/test', 07:59:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:57 INFO - 'SHELL': '/bin/bash', 07:59:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qcXlKpWcMc/Listeners', 07:59:57 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 07:59:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:57 INFO - 'USER': 'cltbld', 07:59:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:57 INFO - 'XPC_FLAGS': '0x0', 07:59:57 INFO - 'XPC_SERVICE_NAME': '0', 07:59:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:58 INFO - Downloading/unpacking blobuploader==1.2.4 07:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59: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 08:00:00 INFO - Downloading blobuploader-1.2.4.tar.gz 08:00:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:00:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:00:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:00:01 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 08:00:01 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 08:00:01 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 08:00:01 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 08:00:01 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 08:00:01 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 08:00:01 INFO - Downloading docopt-0.6.1.tar.gz 08:00:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:00:01 INFO - Installing collected packages: blobuploader, requests, docopt 08:00:01 INFO - Running setup.py install for blobuploader 08:00:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:00:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:00:02 INFO - Running setup.py install for requests 08:00:02 INFO - Running setup.py install for docopt 08:00:02 INFO - Successfully installed blobuploader requests docopt 08:00:02 INFO - Cleaning up... 08:00:02 INFO - Return code: 0 08:00:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:00:02 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')]} 08:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:02 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')]} 08:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:02 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 0x106285490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061fb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7615790d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106099d30>, '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 0x105effdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106091b20>, '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.SNzcGVdkLA/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.qcXlKpWcMc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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 08:00:02 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 08:00:02 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 08:00:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SNzcGVdkLA/Render', 08:00:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:00:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:00:02 INFO - 'HOME': '/Users/cltbld', 08:00:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:00:02 INFO - 'LOGNAME': 'cltbld', 08:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:02 INFO - 'MOZ_NO_REMOTE': '1', 08:00:02 INFO - 'NO_EM_RESTART': '1', 08:00:02 INFO - 'PAGER': '/bin/cat', 08:00:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:02 INFO - 'PWD': '/builds/slave/test', 08:00:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:00:02 INFO - 'SHELL': '/bin/bash', 08:00:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qcXlKpWcMc/Listeners', 08:00:02 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 08:00:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:00:02 INFO - 'USER': 'cltbld', 08:00:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:00:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:02 INFO - 'XPC_FLAGS': '0x0', 08:00:02 INFO - 'XPC_SERVICE_NAME': '0', 08:00:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:00:03 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-hSsAi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:00:03 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-sVJAA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:00:03 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-Df0jAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:00:03 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-5lUu4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:00:03 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-dY9g6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:00:03 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-vhlrAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:00:03 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-9U1pP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:00:03 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-iJ2PaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:00:03 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-AHrus9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:00:04 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-zIf36r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:00:04 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-o8tdNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:00:04 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-lenhc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:00:04 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-2f1qVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:00:04 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-vay4cF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:04 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-1PldGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:00:04 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-nOe_rH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:00:04 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-lAMy3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:00:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:00:04 INFO - Running setup.py install for manifestparser 08:00:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:00:05 INFO - Running setup.py install for mozcrash 08:00:05 INFO - Running setup.py install for mozdebug 08:00:05 INFO - Running setup.py install for mozdevice 08:00:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:00:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:00:05 INFO - Running setup.py install for mozfile 08:00:05 INFO - Running setup.py install for mozhttpd 08:00:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:00:05 INFO - Running setup.py install for mozinfo 08:00:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:00:05 INFO - Running setup.py install for mozInstall 08:00:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:00:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:00:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:00:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:00:06 INFO - Running setup.py install for mozleak 08:00:06 INFO - Running setup.py install for mozlog 08:00:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:00:06 INFO - Running setup.py install for moznetwork 08:00:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:00:06 INFO - Running setup.py install for mozprocess 08:00:06 INFO - Running setup.py install for mozprofile 08:00:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:00:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:00:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:00:06 INFO - Running setup.py install for mozrunner 08:00:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:00:07 INFO - Running setup.py install for mozscreenshot 08:00:07 INFO - Running setup.py install for moztest 08:00:07 INFO - Running setup.py install for mozversion 08:00:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:00:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:00:07 INFO - Cleaning up... 08:00:07 INFO - Return code: 0 08:00:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:00:07 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')]} 08:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:07 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')]} 08:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:07 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 0x106285490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061fb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7615790d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106099d30>, '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 0x105effdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106091b20>, '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.SNzcGVdkLA/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.qcXlKpWcMc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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 08:00:07 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 08:00:07 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 08:00:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SNzcGVdkLA/Render', 08:00:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:00:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:00:07 INFO - 'HOME': '/Users/cltbld', 08:00:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:00:07 INFO - 'LOGNAME': 'cltbld', 08:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:07 INFO - 'MOZ_NO_REMOTE': '1', 08:00:07 INFO - 'NO_EM_RESTART': '1', 08:00:07 INFO - 'PAGER': '/bin/cat', 08:00:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:07 INFO - 'PWD': '/builds/slave/test', 08:00:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:00:07 INFO - 'SHELL': '/bin/bash', 08:00:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qcXlKpWcMc/Listeners', 08:00:07 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 08:00:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:00:07 INFO - 'USER': 'cltbld', 08:00:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:00:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:07 INFO - 'XPC_FLAGS': '0x0', 08:00:07 INFO - 'XPC_SERVICE_NAME': '0', 08:00:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:00:07 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-bYE17o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:00:07 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)) 08:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:00:07 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-iCsnSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:00:07 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)) 08:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:00:07 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-iyjZDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:00:08 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)) 08:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:00:08 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-JZ1hrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:00:08 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)) 08:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:00:08 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-Wvz8t6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:00:08 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)) 08:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:00:08 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-qEhs8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:00:08 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)) 08:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:00:08 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-uE58Gr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:00:08 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)) 08:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:00:08 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-02bsB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:00:08 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)) 08:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:00:08 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-Ay6Qu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:00:08 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)) 08:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:00:08 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-InGXiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:00:08 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)) 08:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:00:08 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-GI7mBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:00:08 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)) 08:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:00:08 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-ZCPerl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:00:09 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)) 08:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:00:09 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-w2P0Wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:00:09 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)) 08:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:00:09 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-IFOhyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:00:09 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)) 08:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:09 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-0B4NGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:09 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)) 08:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:00:09 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-YNlnQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:00:09 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)) 08:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:00:09 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-zChXQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:00:09 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)) 08:00:09 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)) 08:00:09 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)) 08:00:09 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)) 08:00:09 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)) 08:00:09 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)) 08:00:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:00:09 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 08:00:09 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 08:00:09 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 08:00:09 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 08:00:09 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 08:00:09 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 08:00:11 INFO - Downloading blessings-1.6.tar.gz 08:00:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:00:12 INFO - Installing collected packages: blessings 08:00:12 INFO - Running setup.py install for blessings 08:00:12 INFO - Successfully installed blessings 08:00:12 INFO - Cleaning up... 08:00:12 INFO - Return code: 0 08:00:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:00:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:00:12 INFO - Reading from file tmpfile_stdout 08:00:12 INFO - Current package versions: 08:00:12 INFO - blessings == 1.6 08:00:12 INFO - blobuploader == 1.2.4 08:00:12 INFO - docopt == 0.6.1 08:00:12 INFO - functools32 == 3.2.3-2 08:00:12 INFO - jsonschema == 2.5.1 08:00:12 INFO - manifestparser == 1.1 08:00:12 INFO - mozInstall == 1.12 08:00:12 INFO - mozcrash == 0.17 08:00:12 INFO - mozdebug == 0.1 08:00:12 INFO - mozdevice == 0.48 08:00:12 INFO - mozfile == 1.2 08:00:12 INFO - mozhttpd == 0.7 08:00:12 INFO - mozinfo == 0.9 08:00:12 INFO - mozleak == 0.1 08:00:12 INFO - mozlog == 3.4 08:00:12 INFO - moznetwork == 0.27 08:00:12 INFO - mozprocess == 0.23 08:00:12 INFO - mozprofile == 0.28 08:00:12 INFO - mozrunner == 6.12 08:00:12 INFO - mozscreenshot == 0.1 08:00:12 INFO - mozsystemmonitor == 0.3 08:00:12 INFO - moztest == 0.7 08:00:12 INFO - mozversion == 1.4 08:00:12 INFO - psutil == 3.1.1 08:00:12 INFO - requests == 1.2.3 08:00:12 INFO - wsgiref == 0.1.2 08:00:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:00:12 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')]} 08:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:12 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')]} 08:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:12 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 0x106285490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061fb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7615790d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106099d30>, '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 0x105effdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106091b20>, '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.SNzcGVdkLA/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.qcXlKpWcMc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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 08:00:12 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 08:00:12 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 08:00:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SNzcGVdkLA/Render', 08:00:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:00:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:00:12 INFO - 'HOME': '/Users/cltbld', 08:00:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:00:12 INFO - 'LOGNAME': 'cltbld', 08:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:12 INFO - 'MOZ_NO_REMOTE': '1', 08:00:12 INFO - 'NO_EM_RESTART': '1', 08:00:12 INFO - 'PAGER': '/bin/cat', 08:00:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:12 INFO - 'PWD': '/builds/slave/test', 08:00:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:00:12 INFO - 'SHELL': '/bin/bash', 08:00:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qcXlKpWcMc/Listeners', 08:00:12 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 08:00:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:00:12 INFO - 'USER': 'cltbld', 08:00:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:00:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:12 INFO - 'XPC_FLAGS': '0x0', 08:00:12 INFO - 'XPC_SERVICE_NAME': '0', 08:00:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:12 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)) 08:00:12 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)) 08:00:12 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)) 08:00:12 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)) 08:00:12 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)) 08:00:12 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)) 08:00:12 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)) 08:00:12 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)) 08:00:12 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)) 08:00:12 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)) 08:00:12 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)) 08:00:12 INFO - Cleaning up... 08:00:12 INFO - Return code: 0 08:00:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:00:12 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')]} 08:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:12 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')]} 08:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:12 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 0x106285490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061fb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7615790d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106099d30>, '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 0x105effdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106091b20>, '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.SNzcGVdkLA/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.qcXlKpWcMc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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 08:00:12 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 08:00:12 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 08:00:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SNzcGVdkLA/Render', 08:00:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:00:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:00:12 INFO - 'HOME': '/Users/cltbld', 08:00:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:00:12 INFO - 'LOGNAME': 'cltbld', 08:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:12 INFO - 'MOZ_NO_REMOTE': '1', 08:00:12 INFO - 'NO_EM_RESTART': '1', 08:00:12 INFO - 'PAGER': '/bin/cat', 08:00:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:12 INFO - 'PWD': '/builds/slave/test', 08:00:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:00:12 INFO - 'SHELL': '/bin/bash', 08:00:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qcXlKpWcMc/Listeners', 08:00:12 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 08:00:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:00:12 INFO - 'USER': 'cltbld', 08:00:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:00:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:12 INFO - 'XPC_FLAGS': '0x0', 08:00:12 INFO - 'XPC_SERVICE_NAME': '0', 08:00:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:00:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:00:13 INFO - Cleaning up... 08:00:13 INFO - Return code: 0 08:00:13 INFO - Running post-action listener: _resource_record_post_action 08:00:13 INFO - Running post-action listener: _start_resource_monitoring 08:00:13 INFO - Starting resource monitoring. 08:00:13 INFO - [mozharness: 2016-10-29 15:00:13.225421Z] Finished create-virtualenv step (success) 08:00:13 INFO - [mozharness: 2016-10-29 15:00:13.226419Z] Running install step. 08:00:13 INFO - Running pre-action listener: _resource_record_pre_action 08:00:13 INFO - Running main action method: install 08:00:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:00:13 INFO - Reading from file tmpfile_stdout 08:00:13 INFO - Detecting whether we're running mozinstall >=1.0... 08:00:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:00:13 INFO - Reading from file tmpfile_stdout 08:00:13 INFO - Output received: 08:00:13 INFO - Usage: mozinstall [options] installer 08:00:13 INFO - Options: 08:00:13 INFO - -h, --help show this help message and exit 08:00:13 INFO - -d DEST, --destination=DEST 08:00:13 INFO - Directory to install application into. [default: 08:00:13 INFO - "/builds/slave/test"] 08:00:13 INFO - --app=APP Application being installed. [default: firefox] 08:00:13 INFO - mkdir: /builds/slave/test/build/application 08:00:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:00:46 INFO - Reading from file tmpfile_stdout 08:00:46 INFO - Output received: 08:00:46 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:00:46 INFO - Running post-action listener: _resource_record_post_action 08:00:46 INFO - [mozharness: 2016-10-29 15:00:46.667804Z] Finished install step (success) 08:00:46 INFO - [mozharness: 2016-10-29 15:00:46.667997Z] Running run-tests step. 08:00:46 INFO - Running pre-action listener: _resource_record_pre_action 08:00:46 INFO - Running main action method: run_tests 08:00:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:00:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:00:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:00:46 INFO - 2016-10-29 08:00:46.682 screenresolution[1948:18978] starting screenresolution argv=screenresolution get 08:00:46 INFO - 2016-10-29 08:00:46.685 screenresolution[1948:18978] Display 0: 1600x1200x32@60 08:00:46 INFO - 2016-10-29 08:00:46.690 screenresolution[1949:18980] starting screenresolution argv=screenresolution list 08:00:46 INFO - Available Modes on Display 0 08:00:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:00:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:00:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:00:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:00:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:00:46 INFO - Intel Iris: 08:00:46 INFO - Chipset Model: Intel Iris 08:00:46 INFO - Type: GPU 08:00:46 INFO - Bus: Built-In 08:00:46 INFO - VRAM (Dynamic, Max): 1536 MB 08:00:46 INFO - Vendor: Intel (0x8086) 08:00:46 INFO - Device ID: 0x0a2e 08:00:46 INFO - Revision ID: 0x0009 08:00:46 INFO - Displays: 08:00:46 INFO - Display: 08:00:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:00:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:00:46 INFO - Display Serial Number: 1600x1200 60 08:00:46 INFO - Main Display: Yes 08:00:46 INFO - Mirror: Off 08:00:46 INFO - Online: Yes 08:00:46 INFO - Rotation: Supported 08:00:46 INFO - Return code: 0 08:00:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:00:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:00:46 INFO - Python 2.7.3 08:00:46 INFO - Return code: 0 08:00:46 INFO - grabbing minidump binary from tooltool 08:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:46 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 0x106099d30>, '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 0x105effdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106091b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:00:46 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 08:00:46 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 08:00:46 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 08:00:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:00:47 INFO - Return code: 0 08:00:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:00:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:00:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:00:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:00:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:00:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N673DChmTh6paGnkX3YjOw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0316', '--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 08:00:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N673DChmTh6paGnkX3YjOw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0316 --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 08:00:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SNzcGVdkLA/Render', 08:00:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:00:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:00:47 INFO - 'HOME': '/Users/cltbld', 08:00:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:00:47 INFO - 'LOGNAME': 'cltbld', 08:00:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:00:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:00:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:47 INFO - 'MOZ_NO_REMOTE': '1', 08:00:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:00:47 INFO - 'NO_EM_RESTART': '1', 08:00:47 INFO - 'PAGER': '/bin/cat', 08:00:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:00:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:47 INFO - 'PWD': '/builds/slave/test', 08:00:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:00:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:00:47 INFO - 'SHELL': '/bin/bash', 08:00:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qcXlKpWcMc/Listeners', 08:00:47 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 08:00:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:00:47 INFO - 'USER': 'cltbld', 08:00:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:00:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:00:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:47 INFO - 'XPC_FLAGS': '0x0', 08:00:47 INFO - 'XPC_SERVICE_NAME': '0', 08:00:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:00:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N673DChmTh6paGnkX3YjOw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0316', '--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 08:00:47 INFO - mozversion application_buildid: 20161029061621 08:00:47 INFO - mozversion application_changeset: 2d10bed515455ac26b84f225feae8785ea3e600b 08:00:47 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:00:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:00:47 INFO - mozversion application_name: Firefox 08:00:47 INFO - mozversion application_remotingname: firefox-dev 08:00:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:00:47 INFO - mozversion application_vendor: Mozilla 08:00:47 INFO - mozversion application_version: 51.0a2 08:00:47 INFO - mozversion platform_buildid: 20161029061621 08:00:47 INFO - mozversion platform_changeset: 2d10bed515455ac26b84f225feae8785ea3e600b 08:00:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:00:47 INFO - mozversion platform_version: 51.0a2 08:00:47 INFO - using testdate: 1477753247 08:00:47 INFO - actual date: 1477753247 08:00:47 INFO - starting webserver on 'localhost:52412' 08:00:47 INFO - SUITE-START | Running 2 tests 08:00:47 INFO - TEST-START | dromaeo_css 08:00:47 INFO - operating with platform_type : mac_ 08:00:47 INFO - Initialising browser for dromaeo_css test... 08:00:47 INFO - TEST-INFO | started process 1959 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/tmp8sEwki/profile http://localhost:52412/getInfo.html) 08:00:49 INFO - PROCESS | 1959 | __metrics Screen width/height:1600/1200 08:00:49 INFO - PROCESS | 1959 | colorDepth:24 08:00:49 INFO - PROCESS | 1959 | Browser inner width/height: 1024/689 08:00:49 INFO - PROCESS | 1959 | __metrics 08:00:49 INFO - PROCESS | 1959 | 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" 08:00:49 INFO - PROCESS | 1959 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:00:50 INFO - TEST-INFO | 1959: exit 0 08:00:50 INFO - Browser initialized. 08:00:50 INFO - Running cycle 1/1 for dromaeo_css test... 08:00:50 INFO - TEST-INFO | started process 1961 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/tmp8sEwki/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:01:02 INFO - PROCESS | 1961 | RSS: Main: 219766784 08:01:02 INFO - PROCESS | 1961 | 08:01:53 INFO - PROCESS | 1961 | 1477753313269 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] 08:04:05 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:52412/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52412/tests/dromaeo/cssquery-ext.html) 08:04:07 INFO - PROCESS | 1961 | RSS: Main: 371462144 08:04:07 INFO - PROCESS | 1961 | 08:07:10 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:52412/tests/dromaeo/cssquery-ext.html (next: http://localhost:52412/tests/dromaeo/cssquery-jquery.html) 08:07:10 INFO - PROCESS | 1961 | RSS: Main: 352284672 08:07:10 INFO - PROCESS | 1961 | 08:10:13 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:52412/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52412/tests/dromaeo/cssquery-mootools.html) 08:10:13 INFO - PROCESS | 1961 | RSS: Main: 315367424 08:10:13 INFO - PROCESS | 1961 | 08:13:16 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:52412/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52412/tests/dromaeo/cssquery-prototype.html) 08:13:16 INFO - PROCESS | 1961 | RSS: Main: 323129344 08:13:16 INFO - PROCESS | 1961 | 08:16:19 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:52412/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52412/tests/dromaeo/cssquery-yui.html) 08:16:20 INFO - PROCESS | 1961 | RSS: Main: 311287808 08:16:20 INFO - PROCESS | 1961 | 08:19:23 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:52412/tests/dromaeo/cssquery-yui.html (next: http://localhost:52412/tests/dromaeo/cssquery-dojo.html) 08:19:23 INFO - PROCESS | 1961 | RSS: Main: 490602496 08:19:23 INFO - PROCESS | 1961 | 08:19:23 INFO - PROCESS | 1961 | __start_tp_report 08:19:23 INFO - PROCESS | 1961 | _x_x_mozilla_page_load 08:19:23 INFO - PROCESS | 1961 | _x_x_mozilla_page_load_details 08:19:23 INFO - PROCESS | 1961 | |i|pagename|runs| 08:19:23 INFO - PROCESS | 1961 | |0;dojo.html;2828.2081017315154;3328.1180487170905;3340.632530421655;3377.7973321600707;3379.864805407784;5662.207290979266;5703.258576385064;5711.3431955325095;5713.828585142447;5716.8284951451415;5619.297587801525;5665.971670141644;5688.4311568843095;5693.373728889829;5702.258706368167;5153.665011774232;5170.767315470813;5186.662866913657;5197.038547868638;5230.6600070995455;5194.948050519503;5203.323567936163;5220.269162317279;5277.340332458442;5319.680819150844;5212.192110222922;5213.087709650815;5242.659227150242;5273.709945952971;5296.364436267653;5242.9213561796605;5244.292020577231;5269;5287.86780330491;5297.337832770903;5185.066687996159;5232.764525596357;5245.842624721265;5277.815276465343;5282.815101471469;5591.496765291103;5610.551155907518;5644.322681278273;5645.971770141164;5661.631993920382;6124.877502449971;6125.309396713697;6126.23422072241;6150.954337762591;6160.260768707739;6199.938000620026;6273.466755325803;6286.057091436275;6300.054991751228;6309.337519560426;4818.229083346648;5553.944460555384;5603.943960560342;5683.090705487185;5768.596198266123;6356.300806911236;6383.074454204115;6387.936120638734;6390.105385246069;6392.584482008748;6109.480694141048;6133.0800379942475;6143.232095988002;6149.41580549847;6159.384061593894;6135.938640613536;6147.108669242934;6156.353582873823;6158.983767678283;6267.2792628848265;6142.539309551712;6161.075838624242;6173.475254603409;6173.9073913891325;6182.814515564541;6121.112438696364;6169.84575385619;6217.813465595949;6221.782237621662;6224.439800417984;4848.466668666444;4887.462379138292;4962.429320628102;4967.081089998362;5007.899842003139;4396.4284642996845;4422.800973956179;4449.13241917823;4450.643948484114;4454.57681520255;5761.85595360111;5786.884262314814;5796.043652797325;5812.186293918855;5820.417958204231;6259.217597800275;6298.622082675054;6305.936940630627;6312.715927783261;6320.747170113236;5596.244506991586;5648.661080335193;5678;5698.487136157766;5708.1723150143;5379.973100134474;5393.7572809223675;5404.702741349263;5423.918641220384;5466.6993315367245;6307.432331090224;6308.400701933309;6321.304656487875;6329.715162817684;6330.208723909512;6030.939690603038;6170.938290617037;6191.19514463135;6288.685565721604;6329.082283069021;6256.499480041677;6285.905711414424;6306.243250809932;6307.936920630735;6339.366063393623;6158.692065396802;6210;6213.099100630474;6234.189555357774;6238.376162383907;6255.31191568918;6298.370162983848;6325.177726895474;6338.366163383625;6338.366163383809;4763.833265835818;5861.501772349227;5920.73356698941;5990.760369585342;6021.969890150521;6051.848703782441;6054.576179667557;6058.727357269022;6068.21113255274;6075.544334175043;5823.708814559171;5833.737481813244;5883.411658834254;5885.3820348862755;5889.087191485327;5938.346781853907;5986.191864098465;6043.36544662804;6058.848528786815;6066.1204125402455;5532.2254884317035;5613.971930140323;5962.433568810956;5982.102684597346;6015.308239552507 08:19:23 INFO - PROCESS | 1961 | |1;ext.html;463.5573027758491;479.65464865296974;528.7012837746673;541.6398095266651;555.469526602095;22157.556848863034;39189.82430527085;40140.799296003555;40957.976050598714;42652;40571.59428405715;40840.59159408412;40913;41050.56323028695;41059.9735006625;9616;9819;9819.06718861707;9823.459709715962;9866.210703143766;9577.904220957806;9698.127168554829;9700.902990970071;9710.563024663907;9730.367526110815;9559.665411710592;9663.033696630317;9711.417314961125;9714.514274286294;9716.708498745049;9639.518024098803;9648.421094734338;9681.37071090377;9695.612175512972;9698.612055517842;9129.497877616728;9197.356185067049;9199.356045076847;9202.079792020812;9203.263738900872;39357;39651;39672.206555868725;39682.80951571457;39689.20621587581;3253.837308134584;3277.3281477297337;3373.7638365314438;3400.472926696366;3910;25431.61852572213;29250;29473.82104715809;30385.69614303851;31423.685763142304;3175.3173067790535;3185.4106990206656;3211.1008917503136;3234.498652708834;3241.4813629819114;367702;369534;370800;370852.14573926956;371580;56558;57009.714951424976;57044.429555704744;57051;57177.428225718046;33608.99173024813;34269.65730342714;34296.48555271673;35412;59893;16465.753013704805;16587.751183732253;16956;17035.14824258782;17045.31818727262;12993.935030324788;13124.606261812161;13125.803112953314;13129.212247265004;13133.277669728066;18671.346502872333;18676.252949882124;18679.90660046691;18695.626087478173;18700.625987480173;6576.638284894281;6622;7222.530535515175;7615.390768738488;7727.961360193163;758.666186877772;935.5789894547481;998.3410948773775;1012.6202673997251;1025.7589466475372;28892.544133748866;29520.261993450335;29688.554671679944;30443.543346849816;30446;914.5061666700041;970.3659794071249;1070.4059247117925;1078.1051727066515;1098.3300186885992;14985.32566034531;15136.924315378352;15193.696126077417;15313.770293445607;15583.83121265887;700232;708467;708693;709242;709271.4536427285;54077;54691.72654136704;54724.45275547273;54952;55125;1176.5940750441255;1224.3205021213134;1252.6116903759864;1354.2551596621818;1371.1772936238178;29505;29787.55318670265;30286.51696586905;30387.2403189922;30478;47139.528604713516;47743.76128119476;47769;47857.52142478531;47906.802329940634;531932;533788;534256.3287183539;534595;535907;26002.959881605282;26721.19836404911;26749.465010700067;27594;27600.861995689895;45298.54701452943;45748;45894;46015.07969840652;46378.76810615925;37139.442908356934;38089.61910380972;38126.80936595299;38247.80876095602;38302.042448939;36850;37931.62068379281;38080;39269.41095883507;39311;37055.814720926224;37165.62834371622;37742.056448589006;37960;38041.809790950865;25850.870745646152;31180.908668196505;32054;33334.99995000154;33598.66401336053;24457.165712571983;24835;24863.25410237696;25318.493630126926;25415 08:19:23 INFO - PROCESS | 1961 | |2;jquery.html;349.8618045871879;366.5582972518115;373.84672284363415;380.6098748782497;400.66144108228536;14904.850951490482;15328.386864525419;16207.837921620796;20869.895650521765;21375.251866184688;20365.49086272844;21350.932453377347;21482.355529334105;21573.568528629417;21772.673409898864;5920.733566989496;6010.639361638305;6127.509799216052;6194.1328214049845;6208.78269260576;4871.464138944713;5896.410358964091;6067.575269731121;6076.027835546313;6178.5366097542865;4162.687798415116;4401.955980440202;5289.788408463657;6210.726801005806;6279.748810047593;6482;6715.9328406715795;6772.864542709143;6796.762113326059;6807.795766126999;5855.2973643163095;5856.7071646417935;5863.794767183171;5878.177055212273;5880.323762767293;25575.74424255771;26247.73752262472;26505;26740.59889101665;27038.188854334403;2300.505391340853;2539.898404063854;3093.752499800033;3165.5884734984306;3178.507331363642;15832.604184895354;15868.682626347409;15932;16114.597135071599;16450.506484805475;1831.230883029131;1868.8224618661206;1892.5647101166671;1909.8281154696006;1971.0046426554497;108375;109265;109951;114761.99999999917;115788.26317605242;10658.253922225369;10894.237403381687;10960.013598776148;11241.60654377093;11258.774824503627;14215.857841421453;14228.14631122136;14229.64425889361;14232.288385580887;14236.501722439873;8630.39587228888;8648.913510864937;8650.41323944228;8742.650293988296;8825.955870220736;8773.780655483537;8781.473111613195;8904.510251936206;8998.820023599492;9111.726648200565;6747.797566073025;6768.763093291711;6770.526063175629;6779.525433219627;6792.150981127359;1582.8575428211516;1804.5759246577045;1844.2530775036132;1845.713914343279;1867.6918308479221;738.8226825561934;905.5789058088021;968.3076600230869;1010.1514727628827;1063.2238465919768;22165.66751498729;23030;23041.308760737204;23069;23120.4219894504;942.2603256443796;957.861110139026;1007.5012868630075;1010.1514727628827;1014.1835822163082;10234.744131396626;11450.484728187084;11637.487126673479;11846.940765296118;12095.697607559705;625257;629586;634170;634694;637530;123058.15412768816;126113;126264.36867815786;130254.6387584045;130296.3485182568;951.7715748220377;955.6872368867357;985.5860538573817;987.1658448610913;987.5555999800118;18977.715334270273;19362.806371936666;19367;19430.514237144183;19432.514187145436;53527;53900;54647.453525465826;54765.452345476035;55543.72228138995;75590;79541.0114747136;80052.99867503127;80751;81399.59300203461;7654.119776225805;7941.920580794118;7943.761687149395;8480.236778689947;8482.448640838325;9191.172794448532;12297.631071067883;13071.607851764462;13245.20528768277;13406.597802065953;9186.805715256975;10895.673129806119;11031.39327336972;11332.376719280519;11457.427128643369;9667.70996870095;11227.438628068727;11274.887251127384;11527.193096483501;11912.285262884254;11631.243969141979;11671.474783634587;12037.398130093285;12055.336956467478;12162.817557736464;8047.155048720034;8312.293455056146;8360.038595561587;8374.916250837414;8387.664493420194;8853.247473964786;9664.323497355117;10985.231033827555;11304.547818087185;11555.364454955059 08:19:23 INFO - PROCESS | 1961 | |3;mootools.html;1514.182341535571;1527.9312430940608;1733.2460379734816;1896.0235478728448;1905.8856468611875;8560.828783424327;9098.954505227464;9104.226140778026;9116.589753461094;9124.771880702985;7936.127026027132;8145.1854814518665;8153.755387338375;8578.828423431527;8884.644614215424;2334.0897050150456;2377.072941552796;2378.774016468433;2382.7855493005627;2385.4751954569965;2350.612148995414;2374.287713685896;2374.905003799846;2390.091765129257;2392.234484964812;2363.09021026905;2374.905003799846;2380.345405013618;2388.10446082719;2401.5677178107935;2339.1929784224417;2346.7887890089887;2360.704911886014;2363.1728894886824;2366.8698221597892;2144.4960434297927;2252.4594097416666;2259.1302348595746;2260.5026894083276;2262.343920263138;8874.156955089256;8930.151635594673;8970.147835955573;8982.416142950688;9002;5222.97388513055;5401.864953376158;5410.702411367373;5414.729263536808;5422.376426710939;3424.3391954902104;3503.7021853142514;3616.3490571697084;3625.673689367943;3644.9817750911343;901.9458832470073;1067.1622776120707;1079.8596182496303;1098.4946924414699;1099.7525556749747;11819.231749936313;11867.881321186764;11928.70178245542;11955.940220298842;11971.820422693667;4592.540745925381;4730.5032971538185;4820.566149046603;4836.613070954315;4844.563989240985;10139.036791504795;10146.13757830578;10149.797004059878;10157.898421015696;10166.186705063577;5386.569074474032;5386.676799392049;5393.1370980642905;5404.8108316208745;5413.621046526705;3933.7454668445844;4236.555161707976;4746.952530474651;4915.483874193158;4929.260610908321;3916.921661566753;3939.803009849496;4012.3981402789814;4030.6976976726864;4058.411530328086;1279.8080287956882;1282.602393258093;1286.5882917466322;1297.4874924404996;1298.7402519496138;766.9118051424047;859.8753180788875;898.9325800564984;912.8630705394244;920.9171174594319;5761.135829625506;5847.970760146257;5962.433568810956;6210.782622608187;6230.096635987757;891.2468963725642;933.1228645073609;942.6700654770913;978.6232300564192;1011.8937511561327;3436.5017072524342;4074.490688663917;4101.7744024078365;4176.352665336878;4233.91532169361;10901.890981090088;10913.563457461612;11131.053860421793;11156.330620162817;11164.944175279072;10944.39805810688;11069.72325691848;11075.556977720962;11080.944595276973;11109.333439993627;8119.30985866208;8307.501549906903;8340.708075217339;8355.582220889053;8359.164083591713;5119.6416250862085;5890.587658863838;6121.724522396592;6171.84570385744;6228.252609686685;9623.326367154232;9741.366811157252;10036.996300369905;10261.9486902565;10271.281010329503;10496.895031049897;10501;10524;10527.789444211227;10556.944305569688;7040.612766297902;7262.891056634049;7283.380912622274;7635.465517413728;7804.0635123785505;8236.382271329794;8382.371322150984;8532.104129066358;8632.223099921037;8644.135586441556;7447.292507211806;7449.14334851499;7571.810704732426;7694.422918281263;7710.498817576839;7364.968904353288;7458.291462311072;7474.2525747424825;7500.174980752222;7677.923220767944;5982.222311099529;7143.321384468467;7153.4277257820295;7158.355747982707;7160.856782864418;4772.236442169236;4821.831235906727;4948.703077815343;5005.849824505271;5117.8720531987;5026.874328141826;5034.11009119324;5108.693478391308;5219.399769026611;5224.895502090013 08:19:23 INFO - PROCESS | 1961 | |4;prototype.html;296.5299999500792;297.26427092944965;303.69023595932157;309.3951325159312;311.92669722615165;5152.613553983448;5232.790688372465;5291.68249905005;5294.444083371249;5303.867403314909;4735;4879.316635760657;4985.277134815449;5050.545450909417;5096.261042148886;3660.145086832275;3688.6126956669564;3960.6237407446247;3989.780562069078;4000.19996000801;3351.262722201112;3957.4063890416523;3986.6212709792667;4005.819738111792;4007.759534427929;3284.0476261884023;3877.7426961352458;3928.9017774555577;3934.40983852423;3942.9014274643077;3288.96711032889;3810.8757916414447;3949.4075888616935;4002.919941601166;4021.687529670451;3186.9203269918207;3475.6350583188655;3490.7730997485082;3509.982450087759;3521.7182625389905;4817.927731084036;4992.825251116194;5018.64869459138;5019.372578427697;5031.974840125813;3905.531336239641;4303.72025818324;4507.4365704286965;4546.38623785788;4546.522615125397;5023.095842748304;5119.923201151985;5398.6220964532495;5418.480406610905;5418.539424148952;3220.516922461626;3807.3527500325013;3822.6750726188307;3826.770393776382;3833.233353329317;4450.933236001462;5614.557667414688;5651.547876169897;5678.858028549278;5729.083346664514;3708.3881159608363;3867.535895692479;3884.9223015539533;3900.5904380040256;3901.51231096113;3196.946915695505;3440.0730105376506;3510.438329867209;3958.960410395917;3971.523417189898;3710.888673339804;4458.799354029076;4548.204064288802;4578.130155270488;4585.977070114628;4979.4771548987555;5456.836294911159;5457.643549217282;5474.357692692176;5564.944350556442;1286.9806952895715;1304.6999190186311;1314.2114731161228;1319.683276013769;1320.313437012748;723.6707298179316;844.6494704697604;857.4769390671685;860.3977215948861;881.0000649263133;4268.850590229327;4740.5112316033665;4908.2637604358915;5129.487051294841;5176.637635365563;4921.926171107436;5484.7531861066345;5547.2511210986;5584.888302234014;5618.6628802272;4763.595094417014;4932.309476673268;5079.771410286546;5091.414487334004;5101.617378696613;2522.5459417304696;2547.656066431045;2864.88269574866;2893.1899068260923;2927.224285564327;4836.274558816135;5323.9884421959705;5702.885942281131;5741.799037033684;5753.769849206069;4485.573870482299;5604.579656525777;5638.306908974628;5647.830565083054;5675.602707810413;5689.857753556029;5693.17448969897;5711.828645140652;5712.857428514314;5740.225069615632;4190.769507676985;4359.04101097758;5482.616216864782;5512.972435137799;5518.647931256868;5434.239206511171;5435.901536124371;5459.042194409021;5462.890742185214;5487.231787549826;5049.495050494921;5685.147227915846;5696.174054762119;5707.1153971134545;5722.771089156554;3582.8566857325413;3675.9448608270363;3713.2918857324853;3750.2499500099543;3751.4185301278344;4617.6536759742485;5394.568434525307;5443.782248710166;5467.261919640957;5520.834374968757;4668.276417155346;4820.204666230033;5251.711155886463;5314.8937021260135;5362.276092727432;4972.2790195422185;5277.577793776565;5301.183148133337;5320.388155362183;5329.441867903351;4421.562992027668;4815.494373090775;4927.9507204927495;5011.899762004667;5211.557017653542;5292.629515933848;5332.226827110125;5346.786128554814;5446.645968012067;5447.556397554572;5324.733763311897;5334.53300342409;5342.75957581902;5357.142857142839;5408.13469844823 08:19:23 INFO - PROCESS | 1961 | |5;yui.html;594.6640148316201;691.2914262880547;764.9138223722317;785.7367781793099;796.6295672512281;16825.831741682596;17128.82871171288;17272.481825545223;17299.481015569538;18134.183961721723;16162.919185404086;16516;16718;16759.49721508354;16813.747793783103;655.2726473614284;812.9227723366271;834.6536187482187;836.2682652678906;839.102160688064;674.8785218660639;683.4361651637395;809.1382677448498;827.8634025385804;832.7834762961643;853.8249658819927;869.8999615044256;881.8104107616861;883.483162350026;883.5449743382163;874.1826392323198;875.8773771671971;879.1647934462254;879.6701237036143;881.457903389411;509.3760143823823;524.0802391802363;631.7915088020942;643.4241353988155;655.60663601839;15465.381384744596;15472.690546189126;15482.148481833494;15490.61273468161;15501.689966200613;13082.476700932046;13526.32368381577;13588.38852251651;13702.52041178554;14250.714985700331;11392.980860072088;11593;11615.825762613567;11832.053435725122;12027.759444811054;3756.7370284080125;3826.789526576037;3858.0740622250737;3946.3291240488898;3981.6416522513114;96323;123310;124437;124565;125795;10587;10697.358158510515;10897.128229741602;10920.453977301262;10977.560897564168;22211.786804414387;22378.9929453175;22660;22710.864456777424;22794.31617051491;7078.646067696697;7104.147502299757;7118.039064726196;7128.607926563985;7171.89242161368;4279.700420970502;4357.803898824561;4446.710963787344;4455.420795296655;4565.018521017997;3631.94552081719;3704.388775852008;3726.087108658342;3732.6080761520193;3759.793211373401;659.9274079851212;661.0943008078963;663.0948754949459;671.754809494531;673.6564352180424;532.5074306266765;617.3456136495329;638.3552611862053;655.0665301944805;663.6084710021014;8827.16141966512;9485.573149208301;9653.276004299705;9803.803923921481;9851.802963940681;626.2922897126218;626.7202629650963;641.4675819070161;670.1723371636026;675.8546912413855;4548.545145485425;4602.401687780634;4630.490646028934;4655.604273636779;4710.222813235778;111038.44480777706;161287;161336;163196;164992.17503912645;124771.12843307358;127872;139198;140640.59359406275;142582.16760491606;109002.45498772456;113402;118773;120833;121517.78482215242;8759.824803504021;8860.96711183553;8938.284937205139;8987.595558200028;9077.773055673397;62785;64023.67988160029;64348.356516434236;65473;67291;74932.87600686103;75215.62392188005;85708.28646419197;101107.49446252722;101957.49021255143;13081.607551773463;13086.934565327112;13305.600831975056;13375.464981400635;13641.454341826613;12290;12433.813492797795;14865.925670371578;14948.85051149518;15252.084874907541;13188.802167967297;13651.658708532366;13680.384382703001;14031.158130512202;14314.737453866406;14167.362468688727;14378.496752613608;14495.710085798435;14950.327235274657;15143.772843407138;11793.646190614296;12665.050121241127;13370.398332074885;13613.319334033456;13633.522826701017;10560.471976401303;10652.467376630982;11104.333739975627;11154.553817847196;11366.118048800134;11332.320060796379;11336.093112551142;11508.194426390073;11532.423378830857;11621.709457263636 08:19:23 INFO - PROCESS | 1961 | __end_tp_report 08:19:23 INFO - PROCESS | 1961 | __start_cc_report 08:19:23 INFO - PROCESS | 1961 | _x_x_mozilla_cycle_collect,1648 08:19:23 INFO - PROCESS | 1961 | __end_cc_report 08:19:23 INFO - PROCESS | 1961 | __startTimestamp1477754363865__endTimestamp 08:19:23 INFO - PROCESS | 1961 | 08:19:23 INFO - PROCESS | 1961 | ------- Summary: start ------- 08:19:23 INFO - PROCESS | 1961 | Number of tests: 6 08:19:23 INFO - PROCESS | 1961 | 08:19:23 INFO - PROCESS | 1961 | [#0] dojo.html Cycles:165 Average:5720.02 Median:5885.38 stddev:652.80 (11.1%) stddev-sans-first:614.12 08:19:23 INFO - PROCESS | 1961 | Values: 2828.2 3328.1 3340.6 3377.8 3379.9 5662.2 5703.3 5711.3 5713.8 5716.8 5619.3 5666.0 5688.4 5693.4 5702.3 5153.7 5170.8 5186.7 5197.0 5230.7 5194.9 5203.3 5220.3 5277.3 5319.7 5212.2 5213.1 5242.7 5273.7 5296.4 5242.9 5244.3 5269.0 5287.9 5297.3 5185.1 5232.8 5245.8 5277.8 5282.8 5591.5 5610.6 5644.3 5646.0 5661.6 6124.9 6125.3 6126.2 6151.0 6160.3 6199.9 6273.5 6286.1 6300.1 6309.3 4818.2 5553.9 5603.9 5683.1 5768.6 6356.3 6383.1 6387.9 6390.1 6392.6 6109.5 6133.1 6143.2 6149.4 6159.4 6135.9 6147.1 6156.4 6159.0 6267.3 6142.5 6161.1 6173.5 6173.9 6182.8 6121.1 6169.8 6217.8 6221.8 6224.4 4848.5 4887.5 4962.4 4967.1 5007.9 4396.4 4422.8 4449.1 4450.6 4454.6 5761.9 5786.9 5796.0 5812.2 5820.4 6259.2 6298.6 6305.9 6312.7 6320.7 5596.2 5648.7 5678.0 5698.5 5708.2 5380.0 5393.8 5404.7 5423.9 5466.7 6307.4 6308.4 6321.3 6329.7 6330.2 6030.9 6170.9 6191.2 6288.7 6329.1 6256.5 6285.9 6306.2 6307.9 6339.4 6158.7 6210.0 6213.1 6234.2 6238.4 6255.3 6298.4 6325.2 6338.4 6338.4 4763.8 5861.5 5920.7 5990.8 6022.0 6051.8 6054.6 6058.7 6068.2 6075.5 5823.7 5833.7 5883.4 5885.4 5889.1 5938.3 5986.2 6043.4 6058.8 6066.1 5532.2 5614.0 5962.4 5982.1 6015.3 08:19:23 INFO - PROCESS | 1961 | 08:19:23 INFO - PROCESS | 1961 | [#1] ext.html Cycles:180 Average:66363.69 Median:38274.93 stddev:148702.71 (388.5%) stddev-sans-first:149037.54 08:19:23 INFO - PROCESS | 1961 | Values: 463.6 479.7 528.7 541.6 555.5 22157.6 39189.8 40140.8 40958.0 42652.0 40571.6 40840.6 40913.0 41050.6 41060.0 9616.0 9819.0 9819.1 9823.5 9866.2 9577.9 9698.1 9700.9 9710.6 9730.4 9559.7 9663.0 9711.4 9714.5 9716.7 9639.5 9648.4 9681.4 9695.6 9698.6 9129.5 9197.4 9199.4 9202.1 9203.3 39357.0 39651.0 39672.2 39682.8 39689.2 3253.8 3277.3 3373.8 3400.5 3910.0 25431.6 29250.0 29473.8 30385.7 31423.7 3175.3 3185.4 3211.1 3234.5 3241.5 367702.0 369534.0 370800.0 370852.1 371580.0 56558.0 57009.7 57044.4 57051.0 57177.4 33609.0 34269.7 34296.5 35412.0 59893.0 16465.8 16587.8 16956.0 17035.1 17045.3 12993.9 13124.6 13125.8 13129.2 13133.3 18671.3 18676.3 18679.9 18695.6 18700.6 6576.6 6622.0 7222.5 7615.4 7728.0 758.7 935.6 998.3 1012.6 1025.8 28892.5 29520.3 29688.6 30443.5 30446.0 914.5 970.4 1070.4 1078.1 1098.3 14985.3 15136.9 15193.7 15313.8 15583.8 700232.0 708467.0 708693.0 709242.0 709271.5 54077.0 54691.7 54724.5 54952.0 55125.0 1176.6 1224.3 1252.6 1354.3 1371.2 29505.0 29787.6 30286.5 30387.2 30478.0 47139.5 47743.8 47769.0 47857.5 47906.8 531932.0 533788.0 534256.3 534595.0 535907.0 26003.0 26721.2 26749.5 27594.0 27600.9 45298.5 45748.0 45894.0 46015.1 46378.8 37139.4 38089.6 38126.8 38247.8 38302.0 36850.0 37931.6 38080.0 39269.4 39311.0 37055.8 37165.6 37742.1 37960.0 38041.8 25850.9 31180.9 32054.0 33335.0 33598.7 24457.2 24835.0 24863.3 25318.5 25415.0 08:19:23 INFO - PROCESS | 1961 | 08:19:23 INFO - PROCESS | 1961 | [#2] jquery.html Cycles:180 Average:36174.76 Median:26889.39 stddev:105021.05 (390.6%) stddev-sans-first:105281.21 08:19:23 INFO - PROCESS | 1961 | Values: 349.9 366.6 373.8 380.6 400.7 14904.9 15328.4 16207.8 20869.9 21375.3 20365.5 21350.9 21482.4 21573.6 21772.7 5920.7 6010.6 6127.5 6194.1 6208.8 4871.5 5896.4 6067.6 6076.0 6178.5 4162.7 4402.0 5289.8 6210.7 6279.7 6482.0 6715.9 6772.9 6796.8 6807.8 5855.3 5856.7 5863.8 5878.2 5880.3 25575.7 26247.7 26505.0 26740.6 27038.2 2300.5 2539.9 3093.8 3165.6 3178.5 15832.6 15868.7 15932.0 16114.6 16450.5 1831.2 1868.8 1892.6 1909.8 1971.0 108375.0 109265.0 109951.0 114762.0 115788.3 10658.3 10894.2 10960.0 11241.6 11258.8 14215.9 14228.1 14229.6 14232.3 14236.5 8630.4 8648.9 8650.4 8742.7 8826.0 8773.8 8781.5 8904.5 8998.8 9111.7 6747.8 6768.8 6770.5 6779.5 6792.2 1582.9 1804.6 1844.3 1845.7 1867.7 738.8 905.6 968.3 1010.2 1063.2 22165.7 23030.0 23041.3 23069.0 23120.4 942.3 957.9 1007.5 1010.2 1014.2 10234.7 11450.5 11637.5 11846.9 12095.7 625257.0 629586.0 634170.0 634694.0 637530.0 123058.2 126113.0 126264.4 130254.6 130296.3 951.8 955.7 985.6 987.2 987.6 18977.7 19362.8 19367.0 19430.5 19432.5 53527.0 53900.0 54647.5 54765.5 55543.7 75590.0 79541.0 80053.0 80751.0 81399.6 7654.1 7941.9 7943.8 8480.2 8482.4 9191.2 12297.6 13071.6 13245.2 13406.6 9186.8 10895.7 11031.4 11332.4 11457.4 9667.7 11227.4 11274.9 11527.2 11912.3 11631.2 11671.5 12037.4 12055.3 12162.8 8047.2 8312.3 8360.0 8374.9 8387.7 8853.2 9664.3 10985.2 11304.5 11555.4 08:19:23 INFO - PROCESS | 1961 | 08:19:23 INFO - PROCESS | 1961 | [#3] mootools.html Cycles:180 Average:5787.74 Median:4829.22 stddev:3280.33 (67.9%) stddev-sans-first:3273.81 08:19:23 INFO - PROCESS | 1961 | Values: 1514.2 1527.9 1733.2 1896.0 1905.9 8560.8 9099.0 9104.2 9116.6 9124.8 7936.1 8145.2 8153.8 8578.8 8884.6 2334.1 2377.1 2378.8 2382.8 2385.5 2350.6 2374.3 2374.9 2390.1 2392.2 2363.1 2374.9 2380.3 2388.1 2401.6 2339.2 2346.8 2360.7 2363.2 2366.9 2144.5 2252.5 2259.1 2260.5 2262.3 8874.2 8930.2 8970.1 8982.4 9002.0 5223.0 5401.9 5410.7 5414.7 5422.4 3424.3 3503.7 3616.3 3625.7 3645.0 901.9 1067.2 1079.9 1098.5 1099.8 11819.2 11867.9 11928.7 11955.9 11971.8 4592.5 4730.5 4820.6 4836.6 4844.6 10139.0 10146.1 10149.8 10157.9 10166.2 5386.6 5386.7 5393.1 5404.8 5413.6 3933.7 4236.6 4747.0 4915.5 4929.3 3916.9 3939.8 4012.4 4030.7 4058.4 1279.8 1282.6 1286.6 1297.5 1298.7 766.9 859.9 898.9 912.9 920.9 5761.1 5848.0 5962.4 6210.8 6230.1 891.2 933.1 942.7 978.6 1011.9 3436.5 4074.5 4101.8 4176.4 4233.9 10901.9 10913.6 11131.1 11156.3 11164.9 10944.4 11069.7 11075.6 11080.9 11109.3 8119.3 8307.5 8340.7 8355.6 8359.2 5119.6 5890.6 6121.7 6171.8 6228.3 9623.3 9741.4 10037.0 10261.9 10271.3 10496.9 10501.0 10524.0 10527.8 10556.9 7040.6 7262.9 7283.4 7635.5 7804.1 8236.4 8382.4 8532.1 8632.2 8644.1 7447.3 7449.1 7571.8 7694.4 7710.5 7365.0 7458.3 7474.3 7500.2 7677.9 5982.2 7143.3 7153.4 7158.4 7160.9 4772.2 4821.8 4948.7 5005.8 5117.9 5026.9 5034.1 5108.7 5219.4 5224.9 08:19:23 INFO - PROCESS | 1961 | 08:19:23 INFO - PROCESS | 1961 | [#4] prototype.html Cycles:180 Average:4387.64 Median:4975.88 stddev:1343.88 (27.0%) stddev-sans-first:1312.10 08:19:23 INFO - PROCESS | 1961 | Values: 296.5 297.3 303.7 309.4 311.9 5152.6 5232.8 5291.7 5294.4 5303.9 4735.0 4879.3 4985.3 5050.5 5096.3 3660.1 3688.6 3960.6 3989.8 4000.2 3351.3 3957.4 3986.6 4005.8 4007.8 3284.0 3877.7 3928.9 3934.4 3942.9 3289.0 3810.9 3949.4 4002.9 4021.7 3186.9 3475.6 3490.8 3510.0 3521.7 4817.9 4992.8 5018.6 5019.4 5032.0 3905.5 4303.7 4507.4 4546.4 4546.5 5023.1 5119.9 5398.6 5418.5 5418.5 3220.5 3807.4 3822.7 3826.8 3833.2 4450.9 5614.6 5651.5 5678.9 5729.1 3708.4 3867.5 3884.9 3900.6 3901.5 3196.9 3440.1 3510.4 3959.0 3971.5 3710.9 4458.8 4548.2 4578.1 4586.0 4979.5 5456.8 5457.6 5474.4 5564.9 1287.0 1304.7 1314.2 1319.7 1320.3 723.7 844.6 857.5 860.4 881.0 4268.9 4740.5 4908.3 5129.5 5176.6 4921.9 5484.8 5547.3 5584.9 5618.7 4763.6 4932.3 5079.8 5091.4 5101.6 2522.5 2547.7 2864.9 2893.2 2927.2 4836.3 5324.0 5702.9 5741.8 5753.8 4485.6 5604.6 5638.3 5647.8 5675.6 5689.9 5693.2 5711.8 5712.9 5740.2 4190.8 4359.0 5482.6 5513.0 5518.6 5434.2 5435.9 5459.0 5462.9 5487.2 5049.5 5685.1 5696.2 5707.1 5722.8 3582.9 3675.9 3713.3 3750.2 3751.4 4617.7 5394.6 5443.8 5467.3 5520.8 4668.3 4820.2 5251.7 5314.9 5362.3 4972.3 5277.6 5301.2 5320.4 5329.4 4421.6 4815.5 4928.0 5011.9 5211.6 5292.6 5332.2 5346.8 5446.6 5447.6 5324.7 5334.5 5342.8 5357.1 5408.1 08:19:23 INFO - PROCESS | 1961 | 08:19:23 INFO - PROCESS | 1961 | [#5] yui.html Cycles:180 Average:25653.34 Median:13213.13 stddev:41428.94 (313.5%) stddev-sans-first:41502.44 08:19:23 INFO - PROCESS | 1961 | Values: 594.7 691.3 764.9 785.7 796.6 16825.8 17128.8 17272.5 17299.5 18134.2 16162.9 16516.0 16718.0 16759.5 16813.7 655.3 812.9 834.7 836.3 839.1 674.9 683.4 809.1 827.9 832.8 853.8 869.9 881.8 883.5 883.5 874.2 875.9 879.2 879.7 881.5 509.4 524.1 631.8 643.4 655.6 15465.4 15472.7 15482.1 15490.6 15501.7 13082.5 13526.3 13588.4 13702.5 14250.7 11393.0 11593.0 11615.8 11832.1 12027.8 3756.7 3826.8 3858.1 3946.3 3981.6 96323.0 123310.0 124437.0 124565.0 125795.0 10587.0 10697.4 10897.1 10920.5 10977.6 22211.8 22379.0 22660.0 22710.9 22794.3 7078.6 7104.1 7118.0 7128.6 7171.9 4279.7 4357.8 4446.7 4455.4 4565.0 3631.9 3704.4 3726.1 3732.6 3759.8 659.9 661.1 663.1 671.8 673.7 532.5 617.3 638.4 655.1 663.6 8827.2 9485.6 9653.3 9803.8 9851.8 626.3 626.7 641.5 670.2 675.9 4548.5 4602.4 4630.5 4655.6 4710.2 111038.4 161287.0 161336.0 163196.0 164992.2 124771.1 127872.0 139198.0 140640.6 142582.2 109002.5 113402.0 118773.0 120833.0 121517.8 8759.8 8861.0 8938.3 8987.6 9077.8 62785.0 64023.7 64348.4 65473.0 67291.0 74932.9 75215.6 85708.3 101107.5 101957.5 13081.6 13086.9 13305.6 13375.5 13641.5 12290.0 12433.8 14865.9 14948.9 15252.1 13188.8 13651.7 13680.4 14031.2 14314.7 14167.4 14378.5 14495.7 14950.3 15143.8 11793.6 12665.1 13370.4 13613.3 13633.5 10560.5 10652.5 11104.3 11154.6 11366.1 11332.3 11336.1 11508.2 11532.4 11621.7 08:19:23 INFO - PROCESS | 1961 | -------- Summary: end -------- 08:19:23 INFO - PROCESS | 1961 | 08:19:24 INFO - TEST-INFO | 1961: exit 0 08:19:24 INFO - TEST-OK | dromaeo_css | took 1117232ms 08:19:24 INFO - TEST-START | kraken 08:19:24 INFO - operating with platform_type : mac_ 08:19:24 INFO - Initialising browser for kraken test... 08:19:24 INFO - TEST-INFO | started process 1964 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/tmpn5Mxqh/profile http://localhost:52412/getInfo.html) 08:19:26 INFO - PROCESS | 1964 | __metrics Screen width/height:1600/1200 08:19:26 INFO - PROCESS | 1964 | colorDepth:24 08:19:26 INFO - PROCESS | 1964 | Browser inner width/height: 1024/689 08:19:26 INFO - PROCESS | 1964 | __metrics 08:19:26 INFO - PROCESS | 1964 | 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" 08:19:26 INFO - PROCESS | 1964 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:19:27 INFO - TEST-INFO | 1964: exit 0 08:19:27 INFO - Browser initialized. 08:19:27 INFO - Running cycle 1/1 for kraken test... 08:19:27 INFO - TEST-INFO | started process 1965 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/tmpn5Mxqh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:19:39 INFO - PROCESS | 1965 | RSS: Main: 219369472 08:19:39 INFO - PROCESS | 1965 | 08:19:42 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52412/tests/kraken/driver.html?testName=audio-beat-detection) 08:19:43 INFO - PROCESS | 1965 | RSS: Main: 270749696 08:19:43 INFO - PROCESS | 1965 | 08:19:45 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52412/tests/kraken/driver.html?testName=audio-dft) 08:19:46 INFO - PROCESS | 1965 | RSS: Main: 281923584 08:19:46 INFO - PROCESS | 1965 | 08:19:49 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52412/tests/kraken/driver.html?testName=audio-fft) 08:19:50 INFO - PROCESS | 1965 | RSS: Main: 377888768 08:19:50 INFO - PROCESS | 1965 | 08:19:52 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52412/tests/kraken/driver.html?testName=audio-oscillator) 08:19:52 INFO - PROCESS | 1965 | RSS: Main: 280739840 08:19:52 INFO - PROCESS | 1965 | 08:19:54 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52412/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:19:55 INFO - PROCESS | 1965 | RSS: Main: 281022464 08:19:55 INFO - PROCESS | 1965 | 08:19:58 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52412/tests/kraken/driver.html?testName=imaging-darkroom) 08:19:58 INFO - PROCESS | 1965 | RSS: Main: 318832640 08:19:58 INFO - PROCESS | 1965 | 08:20:01 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52412/tests/kraken/driver.html?testName=imaging-desaturate) 08:20:02 INFO - PROCESS | 1965 | RSS: Main: 319893504 08:20:02 INFO - PROCESS | 1965 | 08:20:05 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52412/tests/kraken/driver.html?testName=json-parse-financial) 08:20:06 INFO - PROCESS | 1965 | RSS: Main: 319168512 08:20:06 INFO - PROCESS | 1965 | 08:20:07 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52412/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:20:08 INFO - PROCESS | 1965 | RSS: Main: 291405824 08:20:08 INFO - PROCESS | 1965 | 08:20:10 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52412/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:20:10 INFO - PROCESS | 1965 | RSS: Main: 296714240 08:20:10 INFO - PROCESS | 1965 | 08:20:12 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52412/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:20:13 INFO - PROCESS | 1965 | RSS: Main: 302100480 08:20:13 INFO - PROCESS | 1965 | 08:20:16 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52412/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:20:17 INFO - PROCESS | 1965 | RSS: Main: 309800960 08:20:17 INFO - PROCESS | 1965 | 08:20:20 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52412/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:20:20 INFO - PROCESS | 1965 | RSS: Main: 308625408 08:20:20 INFO - PROCESS | 1965 | 08:20:22 INFO - PROCESS | 1965 | Cycle 1(1): loaded http://localhost:52412/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52412/tests/kraken/driver.html?testName=ai-astar) 08:20:22 INFO - PROCESS | 1965 | RSS: Main: 352796672 08:20:22 INFO - PROCESS | 1965 | 08:20:22 INFO - PROCESS | 1965 | __start_tp_report 08:20:22 INFO - PROCESS | 1965 | _x_x_mozilla_page_load 08:20:22 INFO - PROCESS | 1965 | _x_x_mozilla_page_load_details 08:20:22 INFO - PROCESS | 1965 | |i|pagename|runs| 08:20:22 INFO - PROCESS | 1965 | |0;ai-astar;115;118;123;168;150;112;111;114;114;112 08:20:22 INFO - PROCESS | 1965 | |1;audio-beat-detection;144;106;107;142;110;109;109;109;137;106 08:20:22 INFO - PROCESS | 1965 | |2;audio-dft;185;186;183;186;186;184;184;184;184;182 08:20:22 INFO - PROCESS | 1965 | |3;audio-fft;80;60;58;89;78;84;82;82;81;58 08:20:22 INFO - PROCESS | 1965 | |4;audio-oscillator;87;70;95;69;70;67;93;68;70;89 08:20:22 INFO - PROCESS | 1965 | |5;imaging-gaussian-blur;91;88;92;88;92;89;91;88;92;90 08:20:22 INFO - PROCESS | 1965 | |6;imaging-darkroom;99;100;100;101;102;100;101;100;101;113 08:20:22 INFO - PROCESS | 1965 | |7;imaging-desaturate;86;84;85;83;100;140;141;84;109;142 08:20:22 INFO - PROCESS | 1965 | |8;json-parse-financial;57;55;55;54;56;57;58;57;57;58 08:20:22 INFO - PROCESS | 1965 | |9;json-stringify-tinderbox;66;76;80;71;75;74;71;70;71;71 08:20:22 INFO - PROCESS | 1965 | |10;stanford-crypto-aes;86;82;83;85;84;85;81;81;87;84 08:20:22 INFO - PROCESS | 1965 | |11;stanford-crypto-ccm;139;141;137;135;138;139;140;146;243;137 08:20:22 INFO - PROCESS | 1965 | |12;stanford-crypto-pbkdf2;168;174;171;233;230;163;208;232;172;167 08:20:22 INFO - PROCESS | 1965 | |13;stanford-crypto-sha256-iterative;68;66;67;67;67;68;68;66;67;66 08:20:22 INFO - PROCESS | 1965 | __end_tp_report 08:20:22 INFO - PROCESS | 1965 | __start_cc_report 08:20:22 INFO - PROCESS | 1965 | _x_x_mozilla_cycle_collect,2040 08:20:22 INFO - PROCESS | 1965 | __end_cc_report 08:20:22 INFO - PROCESS | 1965 | __startTimestamp1477754422906__endTimestamp 08:20:22 INFO - PROCESS | 1965 | 08:20:22 INFO - PROCESS | 1965 | ------- Summary: start ------- 08:20:22 INFO - PROCESS | 1965 | Number of tests: 14 08:20:22 INFO - PROCESS | 1965 | 08:20:22 INFO - PROCESS | 1965 | [#0] ai-astar Cycles:10 Average:123.70 Median:116.50 stddev:19.40 (16.6%) stddev-sans-first:20.32 08:20:22 INFO - PROCESS | 1965 | Values: 115.0 118.0 123.0 168.0 150.0 112.0 111.0 114.0 114.0 112.0 08:20:22 INFO - PROCESS | 1965 | 08:20:22 INFO - PROCESS | 1965 | [#1] audio-beat-detection Cycles:10 Average:117.90 Median:109.50 stddev:16.09 (14.7%) stddev-sans-first:14.02 08:20:22 INFO - PROCESS | 1965 | Values: 144.0 106.0 107.0 142.0 110.0 109.0 109.0 109.0 137.0 106.0 08:20:22 INFO - PROCESS | 1965 | 08:20:22 INFO - PROCESS | 1965 | [#2] audio-dft Cycles:10 Average:184.40 Median:184.50 stddev:1.35 (0.7%) stddev-sans-first:1.41 08:20:22 INFO - PROCESS | 1965 | Values: 185.0 186.0 183.0 186.0 186.0 184.0 184.0 184.0 184.0 182.0 08:20:22 INFO - PROCESS | 1965 | 08:20:22 INFO - PROCESS | 1965 | [#3] audio-fft Cycles:10 Average:75.20 Median:81.50 stddev:11.77 (14.4%) stddev-sans-first:12.36 08:20:22 INFO - PROCESS | 1965 | Values: 80.0 60.0 58.0 89.0 78.0 84.0 82.0 82.0 81.0 58.0 08:20:22 INFO - PROCESS | 1965 | 08:20:22 INFO - PROCESS | 1965 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:78.50 stddev:11.59 (14.8%) stddev-sans-first:11.81 08:20:22 INFO - PROCESS | 1965 | Values: 87.0 70.0 95.0 69.0 70.0 67.0 93.0 68.0 70.0 89.0 08:20:22 INFO - PROCESS | 1965 | 08:20:22 INFO - PROCESS | 1965 | [#5] imaging-gaussian-blur Cycles:10 Average:90.10 Median:91.00 stddev:1.73 (1.9%) stddev-sans-first:1.80 08:20:22 INFO - PROCESS | 1965 | Values: 91.0 88.0 92.0 88.0 92.0 89.0 91.0 88.0 92.0 90.0 08:20:22 INFO - PROCESS | 1965 | 08:20:22 INFO - PROCESS | 1965 | [#6] imaging-darkroom Cycles:10 Average:101.70 Median:101.00 stddev:4.06 (4.0%) stddev-sans-first:4.18 08:20:22 INFO - PROCESS | 1965 | Values: 99.0 100.0 100.0 101.0 102.0 100.0 101.0 100.0 101.0 113.0 08:20:22 INFO - PROCESS | 1965 | 08:20:22 INFO - PROCESS | 1965 | [#7] imaging-desaturate Cycles:10 Average:105.40 Median:83.50 stddev:25.94 (31.1%) stddev-sans-first:26.55 08:20:22 INFO - PROCESS | 1965 | Values: 86.0 84.0 85.0 83.0 100.0 140.0 141.0 84.0 109.0 142.0 08:20:22 INFO - PROCESS | 1965 | 08:20:22 INFO - PROCESS | 1965 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:57.00 stddev:1.35 (2.4%) stddev-sans-first:1.41 08:20:22 INFO - PROCESS | 1965 | Values: 57.0 55.0 55.0 54.0 56.0 57.0 58.0 57.0 57.0 58.0 08:20:22 INFO - PROCESS | 1965 | 08:20:22 INFO - PROCESS | 1965 | [#9] json-stringify-tinderbox Cycles:10 Average:72.50 Median:72.50 stddev:3.87 (5.3%) stddev-sans-first:3.31 08:20:22 INFO - PROCESS | 1965 | Values: 66.0 76.0 80.0 71.0 75.0 74.0 71.0 70.0 71.0 71.0 08:20:22 INFO - PROCESS | 1965 | 08:20:22 INFO - PROCESS | 1965 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.50 stddev:2.04 (2.4%) stddev-sans-first:2.01 08:20:22 INFO - PROCESS | 1965 | Values: 86.0 82.0 83.0 85.0 84.0 85.0 81.0 81.0 87.0 84.0 08:20:22 INFO - PROCESS | 1965 | 08:20:22 INFO - PROCESS | 1965 | [#11] stanford-crypto-ccm Cycles:10 Average:149.50 Median:139.50 stddev:32.99 (23.6%) stddev-sans-first:34.77 08:20:22 INFO - PROCESS | 1965 | Values: 139.0 141.0 137.0 135.0 138.0 139.0 140.0 146.0 243.0 137.0 08:20:22 INFO - PROCESS | 1965 | 08:20:22 INFO - PROCESS | 1965 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.80 Median:191.00 stddev:30.16 (15.8%) stddev-sans-first:30.74 08:20:22 INFO - PROCESS | 1965 | Values: 168.0 174.0 171.0 233.0 230.0 163.0 208.0 232.0 172.0 167.0 08:20:22 INFO - PROCESS | 1965 | 08:20:22 INFO - PROCESS | 1965 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 08:20:22 INFO - PROCESS | 1965 | Values: 68.0 66.0 67.0 67.0 67.0 68.0 68.0 66.0 67.0 66.0 08:20:22 INFO - PROCESS | 1965 | -------- Summary: end -------- 08:20:22 INFO - PROCESS | 1965 | 08:20:23 INFO - TEST-INFO | 1965: exit 0 08:20:23 INFO - TEST-OK | kraken | took 59268ms 08:20:23 INFO - SUITE-END | took 1176s 08:20:24 INFO - Completed test suite (00:19:36) 08:20:24 INFO - javascript benchmark 08:20:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2828.2081017315154, 3328.1180487170905, 3340.632530421655, 3377.7973321600707, 3379.864805407784, 5662.207290979266, 5703.258576385064, 5711.3431955325095, 5713.828585142447, 5716.8284951451415, 5619.297587801525, 5665.971670141644, 5688.4311568843095, 5693.373728889829, 5702.258706368167, 5153.665011774232, 5170.767315470813, 5186.662866913657, 5197.038547868638, 5230.6600070995455, 5194.948050519503, 5203.323567936163, 5220.269162317279, 5277.340332458442, 5319.680819150844, 5212.192110222922, 5213.087709650815, 5242.659227150242, 5273.709945952971, 5296.364436267653, 5242.9213561796605, 5244.292020577231, 5269.0, 5287.86780330491, 5297.337832770903, 5185.066687996159, 5232.764525596357, 5245.842624721265, 5277.815276465343, 5282.815101471469, 5591.496765291103, 5610.551155907518, 5644.322681278273, 5645.971770141164, 5661.631993920382, 6124.877502449971, 6125.309396713697, 6126.23422072241, 6150.954337762591, 6160.260768707739, 6199.938000620026, 6273.466755325803, 6286.057091436275, 6300.054991751228, 6309.337519560426, 4818.229083346648, 5553.944460555384, 5603.943960560342, 5683.090705487185, 5768.596198266123, 6356.300806911236, 6383.074454204115, 6387.936120638734, 6390.105385246069, 6392.584482008748, 6109.480694141048, 6133.0800379942475, 6143.232095988002, 6149.41580549847, 6159.384061593894, 6135.938640613536, 6147.108669242934, 6156.353582873823, 6158.983767678283, 6267.2792628848265, 6142.539309551712, 6161.075838624242, 6173.475254603409, 6173.9073913891325, 6182.814515564541, 6121.112438696364, 6169.84575385619, 6217.813465595949, 6221.782237621662, 6224.439800417984, 4848.466668666444, 4887.462379138292, 4962.429320628102, 4967.081089998362, 5007.899842003139, 4396.4284642996845, 4422.800973956179, 4449.13241917823, 4450.643948484114, 4454.57681520255, 5761.85595360111, 5786.884262314814, 5796.043652797325, 5812.186293918855, 5820.417958204231, 6259.217597800275, 6298.622082675054, 6305.936940630627, 6312.715927783261, 6320.747170113236, 5596.244506991586, 5648.661080335193, 5678.0, 5698.487136157766, 5708.1723150143, 5379.973100134474, 5393.7572809223675, 5404.702741349263, 5423.918641220384, 5466.6993315367245, 6307.432331090224, 6308.400701933309, 6321.304656487875, 6329.715162817684, 6330.208723909512, 6030.939690603038, 6170.938290617037, 6191.19514463135, 6288.685565721604, 6329.082283069021, 6256.499480041677, 6285.905711414424, 6306.243250809932, 6307.936920630735, 6339.366063393623, 6158.692065396802, 6210.0, 6213.099100630474, 6234.189555357774, 6238.376162383907, 6255.31191568918, 6298.370162983848, 6325.177726895474, 6338.366163383625, 6338.366163383809, 4763.833265835818, 5861.501772349227, 5920.73356698941, 5990.760369585342, 6021.969890150521, 6051.848703782441, 6054.576179667557, 6058.727357269022, 6068.21113255274, 6075.544334175043, 5823.708814559171, 5833.737481813244, 5883.411658834254, 5885.3820348862755, 5889.087191485327, 5938.346781853907, 5986.191864098465, 6043.36544662804, 6058.848528786815, 6066.1204125402455, 5532.2254884317035, 5613.971930140323, 5962.433568810956, 5982.102684597346, 6015.308239552507], "value": 5676.860200830368, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [463.5573027758491, 479.65464865296974, 528.7012837746673, 541.6398095266651, 555.469526602095, 22157.556848863034, 39189.82430527085, 40140.799296003555, 40957.976050598714, 42652.0, 40571.59428405715, 40840.59159408412, 40913.0, 41050.56323028695, 41059.9735006625, 9616.0, 9819.0, 9819.06718861707, 9823.459709715962, 9866.210703143766, 9577.904220957806, 9698.127168554829, 9700.902990970071, 9710.563024663907, 9730.367526110815, 9559.665411710592, 9663.033696630317, 9711.417314961125, 9714.514274286294, 9716.708498745049, 9639.518024098803, 9648.421094734338, 9681.37071090377, 9695.612175512972, 9698.612055517842, 9129.497877616728, 9197.356185067049, 9199.356045076847, 9202.079792020812, 9203.263738900872, 39357.0, 39651.0, 39672.206555868725, 39682.80951571457, 39689.20621587581, 3253.837308134584, 3277.3281477297337, 3373.7638365314438, 3400.472926696366, 3910.0, 25431.61852572213, 29250.0, 29473.82104715809, 30385.69614303851, 31423.685763142304, 3175.3173067790535, 3185.4106990206656, 3211.1008917503136, 3234.498652708834, 3241.4813629819114, 367702.0, 369534.0, 370800.0, 370852.14573926956, 371580.0, 56558.0, 57009.714951424976, 57044.429555704744, 57051.0, 57177.428225718046, 33608.99173024813, 34269.65730342714, 34296.48555271673, 35412.0, 59893.0, 16465.753013704805, 16587.751183732253, 16956.0, 17035.14824258782, 17045.31818727262, 12993.935030324788, 13124.606261812161, 13125.803112953314, 13129.212247265004, 13133.277669728066, 18671.346502872333, 18676.252949882124, 18679.90660046691, 18695.626087478173, 18700.625987480173, 6576.638284894281, 6622.0, 7222.530535515175, 7615.390768738488, 7727.961360193163, 758.666186877772, 935.5789894547481, 998.3410948773775, 1012.6202673997251, 1025.7589466475372, 28892.544133748866, 29520.261993450335, 29688.554671679944, 30443.543346849816, 30446.0, 914.5061666700041, 970.3659794071249, 1070.4059247117925, 1078.1051727066515, 1098.3300186885992, 14985.32566034531, 15136.924315378352, 15193.696126077417, 15313.770293445607, 15583.83121265887, 700232.0, 708467.0, 708693.0, 709242.0, 709271.4536427285, 54077.0, 54691.72654136704, 54724.45275547273, 54952.0, 55125.0, 1176.5940750441255, 1224.3205021213134, 1252.6116903759864, 1354.2551596621818, 1371.1772936238178, 29505.0, 29787.55318670265, 30286.51696586905, 30387.2403189922, 30478.0, 47139.528604713516, 47743.76128119476, 47769.0, 47857.52142478531, 47906.802329940634, 531932.0, 533788.0, 534256.3287183539, 534595.0, 535907.0, 26002.959881605282, 26721.19836404911, 26749.465010700067, 27594.0, 27600.861995689895, 45298.54701452943, 45748.0, 45894.0, 46015.07969840652, 46378.76810615925, 37139.442908356934, 38089.61910380972, 38126.80936595299, 38247.80876095602, 38302.042448939, 36850.0, 37931.62068379281, 38080.0, 39269.41095883507, 39311.0, 37055.814720926224, 37165.62834371622, 37742.056448589006, 37960.0, 38041.809790950865, 25850.870745646152, 31180.908668196505, 32054.0, 33334.99995000154, 33598.66401336053, 24457.165712571983, 24835.0, 24863.25410237696, 25318.493630126926, 25415.0], "value": 19255.061526446287, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.8618045871879, 366.5582972518115, 373.84672284363415, 380.6098748782497, 400.66144108228536, 14904.850951490482, 15328.386864525419, 16207.837921620796, 20869.895650521765, 21375.251866184688, 20365.49086272844, 21350.932453377347, 21482.355529334105, 21573.568528629417, 21772.673409898864, 5920.733566989496, 6010.639361638305, 6127.509799216052, 6194.1328214049845, 6208.78269260576, 4871.464138944713, 5896.410358964091, 6067.575269731121, 6076.027835546313, 6178.5366097542865, 4162.687798415116, 4401.955980440202, 5289.788408463657, 6210.726801005806, 6279.748810047593, 6482.0, 6715.9328406715795, 6772.864542709143, 6796.762113326059, 6807.795766126999, 5855.2973643163095, 5856.7071646417935, 5863.794767183171, 5878.177055212273, 5880.323762767293, 25575.74424255771, 26247.73752262472, 26505.0, 26740.59889101665, 27038.188854334403, 2300.505391340853, 2539.898404063854, 3093.752499800033, 3165.5884734984306, 3178.507331363642, 15832.604184895354, 15868.682626347409, 15932.0, 16114.597135071599, 16450.506484805475, 1831.230883029131, 1868.8224618661206, 1892.5647101166671, 1909.8281154696006, 1971.0046426554497, 108375.0, 109265.0, 109951.0, 114761.99999999917, 115788.26317605242, 10658.253922225369, 10894.237403381687, 10960.013598776148, 11241.60654377093, 11258.774824503627, 14215.857841421453, 14228.14631122136, 14229.64425889361, 14232.288385580887, 14236.501722439873, 8630.39587228888, 8648.913510864937, 8650.41323944228, 8742.650293988296, 8825.955870220736, 8773.780655483537, 8781.473111613195, 8904.510251936206, 8998.820023599492, 9111.726648200565, 6747.797566073025, 6768.763093291711, 6770.526063175629, 6779.525433219627, 6792.150981127359, 1582.8575428211516, 1804.5759246577045, 1844.2530775036132, 1845.713914343279, 1867.6918308479221, 738.8226825561934, 905.5789058088021, 968.3076600230869, 1010.1514727628827, 1063.2238465919768, 22165.66751498729, 23030.0, 23041.308760737204, 23069.0, 23120.4219894504, 942.2603256443796, 957.861110139026, 1007.5012868630075, 1010.1514727628827, 1014.1835822163082, 10234.744131396626, 11450.484728187084, 11637.487126673479, 11846.940765296118, 12095.697607559705, 625257.0, 629586.0, 634170.0, 634694.0, 637530.0, 123058.15412768816, 126113.0, 126264.36867815786, 130254.6387584045, 130296.3485182568, 951.7715748220377, 955.6872368867357, 985.5860538573817, 987.1658448610913, 987.5555999800118, 18977.715334270273, 19362.806371936666, 19367.0, 19430.514237144183, 19432.514187145436, 53527.0, 53900.0, 54647.453525465826, 54765.452345476035, 55543.72228138995, 75590.0, 79541.0114747136, 80052.99867503127, 80751.0, 81399.59300203461, 7654.119776225805, 7941.920580794118, 7943.761687149395, 8480.236778689947, 8482.448640838325, 9191.172794448532, 12297.631071067883, 13071.607851764462, 13245.20528768277, 13406.597802065953, 9186.805715256975, 10895.673129806119, 11031.39327336972, 11332.376719280519, 11457.427128643369, 9667.70996870095, 11227.438628068727, 11274.887251127384, 11527.193096483501, 11912.285262884254, 11631.243969141979, 11671.474783634587, 12037.398130093285, 12055.336956467478, 12162.817557736464, 8047.155048720034, 8312.293455056146, 8360.038595561587, 8374.916250837414, 8387.664493420194, 8853.247473964786, 9664.323497355117, 10985.231033827555, 11304.547818087185, 11555.364454955059], "value": 9927.520346864756, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1514.182341535571, 1527.9312430940608, 1733.2460379734816, 1896.0235478728448, 1905.8856468611875, 8560.828783424327, 9098.954505227464, 9104.226140778026, 9116.589753461094, 9124.771880702985, 7936.127026027132, 8145.1854814518665, 8153.755387338375, 8578.828423431527, 8884.644614215424, 2334.0897050150456, 2377.072941552796, 2378.774016468433, 2382.7855493005627, 2385.4751954569965, 2350.612148995414, 2374.287713685896, 2374.905003799846, 2390.091765129257, 2392.234484964812, 2363.09021026905, 2374.905003799846, 2380.345405013618, 2388.10446082719, 2401.5677178107935, 2339.1929784224417, 2346.7887890089887, 2360.704911886014, 2363.1728894886824, 2366.8698221597892, 2144.4960434297927, 2252.4594097416666, 2259.1302348595746, 2260.5026894083276, 2262.343920263138, 8874.156955089256, 8930.151635594673, 8970.147835955573, 8982.416142950688, 9002.0, 5222.97388513055, 5401.864953376158, 5410.702411367373, 5414.729263536808, 5422.376426710939, 3424.3391954902104, 3503.7021853142514, 3616.3490571697084, 3625.673689367943, 3644.9817750911343, 901.9458832470073, 1067.1622776120707, 1079.8596182496303, 1098.4946924414699, 1099.7525556749747, 11819.231749936313, 11867.881321186764, 11928.70178245542, 11955.940220298842, 11971.820422693667, 4592.540745925381, 4730.5032971538185, 4820.566149046603, 4836.613070954315, 4844.563989240985, 10139.036791504795, 10146.13757830578, 10149.797004059878, 10157.898421015696, 10166.186705063577, 5386.569074474032, 5386.676799392049, 5393.1370980642905, 5404.8108316208745, 5413.621046526705, 3933.7454668445844, 4236.555161707976, 4746.952530474651, 4915.483874193158, 4929.260610908321, 3916.921661566753, 3939.803009849496, 4012.3981402789814, 4030.6976976726864, 4058.411530328086, 1279.8080287956882, 1282.602393258093, 1286.5882917466322, 1297.4874924404996, 1298.7402519496138, 766.9118051424047, 859.8753180788875, 898.9325800564984, 912.8630705394244, 920.9171174594319, 5761.135829625506, 5847.970760146257, 5962.433568810956, 6210.782622608187, 6230.096635987757, 891.2468963725642, 933.1228645073609, 942.6700654770913, 978.6232300564192, 1011.8937511561327, 3436.5017072524342, 4074.490688663917, 4101.7744024078365, 4176.352665336878, 4233.91532169361, 10901.890981090088, 10913.563457461612, 11131.053860421793, 11156.330620162817, 11164.944175279072, 10944.39805810688, 11069.72325691848, 11075.556977720962, 11080.944595276973, 11109.333439993627, 8119.30985866208, 8307.501549906903, 8340.708075217339, 8355.582220889053, 8359.164083591713, 5119.6416250862085, 5890.587658863838, 6121.724522396592, 6171.84570385744, 6228.252609686685, 9623.326367154232, 9741.366811157252, 10036.996300369905, 10261.9486902565, 10271.281010329503, 10496.895031049897, 10501.0, 10524.0, 10527.789444211227, 10556.944305569688, 7040.612766297902, 7262.891056634049, 7283.380912622274, 7635.465517413728, 7804.0635123785505, 8236.382271329794, 8382.371322150984, 8532.104129066358, 8632.223099921037, 8644.135586441556, 7447.292507211806, 7449.14334851499, 7571.810704732426, 7694.422918281263, 7710.498817576839, 7364.968904353288, 7458.291462311072, 7474.2525747424825, 7500.174980752222, 7677.923220767944, 5982.222311099529, 7143.321384468467, 7153.4277257820295, 7158.355747982707, 7160.856782864418, 4772.236442169236, 4821.831235906727, 4948.703077815343, 5005.849824505271, 5117.8720531987, 5026.874328141826, 5034.11009119324, 5108.693478391308, 5219.399769026611, 5224.895502090013], "value": 4633.099297368762, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.5299999500792, 297.26427092944965, 303.69023595932157, 309.3951325159312, 311.92669722615165, 5152.613553983448, 5232.790688372465, 5291.68249905005, 5294.444083371249, 5303.867403314909, 4735.0, 4879.316635760657, 4985.277134815449, 5050.545450909417, 5096.261042148886, 3660.145086832275, 3688.6126956669564, 3960.6237407446247, 3989.780562069078, 4000.19996000801, 3351.262722201112, 3957.4063890416523, 3986.6212709792667, 4005.819738111792, 4007.759534427929, 3284.0476261884023, 3877.7426961352458, 3928.9017774555577, 3934.40983852423, 3942.9014274643077, 3288.96711032889, 3810.8757916414447, 3949.4075888616935, 4002.919941601166, 4021.687529670451, 3186.9203269918207, 3475.6350583188655, 3490.7730997485082, 3509.982450087759, 3521.7182625389905, 4817.927731084036, 4992.825251116194, 5018.64869459138, 5019.372578427697, 5031.974840125813, 3905.531336239641, 4303.72025818324, 4507.4365704286965, 4546.38623785788, 4546.522615125397, 5023.095842748304, 5119.923201151985, 5398.6220964532495, 5418.480406610905, 5418.539424148952, 3220.516922461626, 3807.3527500325013, 3822.6750726188307, 3826.770393776382, 3833.233353329317, 4450.933236001462, 5614.557667414688, 5651.547876169897, 5678.858028549278, 5729.083346664514, 3708.3881159608363, 3867.535895692479, 3884.9223015539533, 3900.5904380040256, 3901.51231096113, 3196.946915695505, 3440.0730105376506, 3510.438329867209, 3958.960410395917, 3971.523417189898, 3710.888673339804, 4458.799354029076, 4548.204064288802, 4578.130155270488, 4585.977070114628, 4979.4771548987555, 5456.836294911159, 5457.643549217282, 5474.357692692176, 5564.944350556442, 1286.9806952895715, 1304.6999190186311, 1314.2114731161228, 1319.683276013769, 1320.313437012748, 723.6707298179316, 844.6494704697604, 857.4769390671685, 860.3977215948861, 881.0000649263133, 4268.850590229327, 4740.5112316033665, 4908.2637604358915, 5129.487051294841, 5176.637635365563, 4921.926171107436, 5484.7531861066345, 5547.2511210986, 5584.888302234014, 5618.6628802272, 4763.595094417014, 4932.309476673268, 5079.771410286546, 5091.414487334004, 5101.617378696613, 2522.5459417304696, 2547.656066431045, 2864.88269574866, 2893.1899068260923, 2927.224285564327, 4836.274558816135, 5323.9884421959705, 5702.885942281131, 5741.799037033684, 5753.769849206069, 4485.573870482299, 5604.579656525777, 5638.306908974628, 5647.830565083054, 5675.602707810413, 5689.857753556029, 5693.17448969897, 5711.828645140652, 5712.857428514314, 5740.225069615632, 4190.769507676985, 4359.04101097758, 5482.616216864782, 5512.972435137799, 5518.647931256868, 5434.239206511171, 5435.901536124371, 5459.042194409021, 5462.890742185214, 5487.231787549826, 5049.495050494921, 5685.147227915846, 5696.174054762119, 5707.1153971134545, 5722.771089156554, 3582.8566857325413, 3675.9448608270363, 3713.2918857324853, 3750.2499500099543, 3751.4185301278344, 4617.6536759742485, 5394.568434525307, 5443.782248710166, 5467.261919640957, 5520.834374968757, 4668.276417155346, 4820.204666230033, 5251.711155886463, 5314.8937021260135, 5362.276092727432, 4972.2790195422185, 5277.577793776565, 5301.183148133337, 5320.388155362183, 5329.441867903351, 4421.562992027668, 4815.494373090775, 4927.9507204927495, 5011.899762004667, 5211.557017653542, 5292.629515933848, 5332.226827110125, 5346.786128554814, 5446.645968012067, 5447.556397554572, 5324.733763311897, 5334.53300342409, 5342.75957581902, 5357.142857142839, 5408.13469844823], "value": 3960.1728246216435, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.6640148316201, 691.2914262880547, 764.9138223722317, 785.7367781793099, 796.6295672512281, 16825.831741682596, 17128.82871171288, 17272.481825545223, 17299.481015569538, 18134.183961721723, 16162.919185404086, 16516.0, 16718.0, 16759.49721508354, 16813.747793783103, 655.2726473614284, 812.9227723366271, 834.6536187482187, 836.2682652678906, 839.102160688064, 674.8785218660639, 683.4361651637395, 809.1382677448498, 827.8634025385804, 832.7834762961643, 853.8249658819927, 869.8999615044256, 881.8104107616861, 883.483162350026, 883.5449743382163, 874.1826392323198, 875.8773771671971, 879.1647934462254, 879.6701237036143, 881.457903389411, 509.3760143823823, 524.0802391802363, 631.7915088020942, 643.4241353988155, 655.60663601839, 15465.381384744596, 15472.690546189126, 15482.148481833494, 15490.61273468161, 15501.689966200613, 13082.476700932046, 13526.32368381577, 13588.38852251651, 13702.52041178554, 14250.714985700331, 11392.980860072088, 11593.0, 11615.825762613567, 11832.053435725122, 12027.759444811054, 3756.7370284080125, 3826.789526576037, 3858.0740622250737, 3946.3291240488898, 3981.6416522513114, 96323.0, 123310.0, 124437.0, 124565.0, 125795.0, 10587.0, 10697.358158510515, 10897.128229741602, 10920.453977301262, 10977.560897564168, 22211.786804414387, 22378.9929453175, 22660.0, 22710.864456777424, 22794.31617051491, 7078.646067696697, 7104.147502299757, 7118.039064726196, 7128.607926563985, 7171.89242161368, 4279.700420970502, 4357.803898824561, 4446.710963787344, 4455.420795296655, 4565.018521017997, 3631.94552081719, 3704.388775852008, 3726.087108658342, 3732.6080761520193, 3759.793211373401, 659.9274079851212, 661.0943008078963, 663.0948754949459, 671.754809494531, 673.6564352180424, 532.5074306266765, 617.3456136495329, 638.3552611862053, 655.0665301944805, 663.6084710021014, 8827.16141966512, 9485.573149208301, 9653.276004299705, 9803.803923921481, 9851.802963940681, 626.2922897126218, 626.7202629650963, 641.4675819070161, 670.1723371636026, 675.8546912413855, 4548.545145485425, 4602.401687780634, 4630.490646028934, 4655.604273636779, 4710.222813235778, 111038.44480777706, 161287.0, 161336.0, 163196.0, 164992.17503912645, 124771.12843307358, 127872.0, 139198.0, 140640.59359406275, 142582.16760491606, 109002.45498772456, 113402.0, 118773.0, 120833.0, 121517.78482215242, 8759.824803504021, 8860.96711183553, 8938.284937205139, 8987.595558200028, 9077.773055673397, 62785.0, 64023.67988160029, 64348.356516434236, 65473.0, 67291.0, 74932.87600686103, 75215.62392188005, 85708.28646419197, 101107.49446252722, 101957.49021255143, 13081.607551773463, 13086.934565327112, 13305.600831975056, 13375.464981400635, 13641.454341826613, 12290.0, 12433.813492797795, 14865.925670371578, 14948.85051149518, 15252.084874907541, 13188.802167967297, 13651.658708532366, 13680.384382703001, 14031.158130512202, 14314.737453866406, 14167.362468688727, 14378.496752613608, 14495.710085798435, 14950.327235274657, 15143.772843407138, 11793.646190614296, 12665.050121241127, 13370.398332074885, 13613.319334033456, 13633.522826701017, 10560.471976401303, 10652.467376630982, 11104.333739975627, 11154.553817847196, 11366.118048800134, 11332.320060796379, 11336.093112551142, 11508.194426390073, 11532.423378830857, 11621.709457263636], "value": 7854.00859536364, "unit": "score"}], "name": "dromaeo_css", "value": 7340.115892074822, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 118.0, 123.0, 168.0, 150.0, 112.0, 111.0, 114.0, 114.0, 112.0], "value": 123.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 106.0, 107.0, 142.0, 110.0, 109.0, 109.0, 109.0, 137.0, 106.0], "value": 117.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 183.0, 186.0, 186.0, 184.0, 184.0, 184.0, 184.0, 182.0], "value": 184.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 58.0, 89.0, 78.0, 84.0, 82.0, 82.0, 81.0, 58.0], "value": 75.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 95.0, 69.0, 70.0, 67.0, 93.0, 68.0, 70.0, 89.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 92.0, 88.0, 92.0, 89.0, 91.0, 88.0, 92.0, 90.0], "value": 90.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 100.0, 100.0, 101.0, 102.0, 100.0, 101.0, 100.0, 101.0, 113.0], "value": 101.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 83.0, 100.0, 140.0, 141.0, 84.0, 109.0, 142.0], "value": 105.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 55.0, 54.0, 56.0, 57.0, 58.0, 57.0, 57.0, 58.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 76.0, 80.0, 71.0, 75.0, 74.0, 71.0, 70.0, 71.0, 71.0], "value": 72.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 83.0, 85.0, 84.0, 85.0, 81.0, 81.0, 87.0, 84.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 141.0, 137.0, 135.0, 138.0, 139.0, 140.0, 146.0, 243.0, 137.0], "value": 149.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 174.0, 171.0, 233.0, 230.0, 163.0, 208.0, 232.0, 172.0, 167.0], "value": 191.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 67.0, 67.0, 68.0, 68.0, 66.0, 67.0, 66.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1497.2, "alertThreshold": 2.0}]} 08:20:24 INFO - Return code: 0 08:20:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:20:24 INFO - # TBPL SUCCESS # 08:20:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:20:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:20:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:20:24 INFO - 2016-10-29 08:20:24.256 screenresolution[1969:21024] starting screenresolution argv=screenresolution get 08:20:24 INFO - 2016-10-29 08:20:24.258 screenresolution[1969:21024] Display 0: 1600x1200x32@60 08:20:24 INFO - 2016-10-29 08:20:24.264 screenresolution[1970:21027] starting screenresolution argv=screenresolution list 08:20:24 INFO - Available Modes on Display 0 08:20:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:20:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:20:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:20:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:20:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:20:24 INFO - Intel Iris: 08:20:24 INFO - Chipset Model: Intel Iris 08:20:24 INFO - Type: GPU 08:20:24 INFO - Bus: Built-In 08:20:24 INFO - VRAM (Dynamic, Max): 1536 MB 08:20:24 INFO - Vendor: Intel (0x8086) 08:20:24 INFO - Device ID: 0x0a2e 08:20:24 INFO - Revision ID: 0x0009 08:20:24 INFO - Displays: 08:20:24 INFO - Display: 08:20:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:20:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:20:24 INFO - Display Serial Number: 1600x1200 60 08:20:24 INFO - Main Display: Yes 08:20:24 INFO - Mirror: Off 08:20:24 INFO - Online: Yes 08:20:24 INFO - Rotation: Supported 08:20:24 INFO - Return code: 0 08:20:24 INFO - Running post-action listener: _resource_record_post_action 08:20:24 INFO - [mozharness: 2016-10-29 15:20:24.498119Z] Finished run-tests step (success) 08:20:24 INFO - Running post-run listener: _resource_record_post_run 08:20:24 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 1490944; Write bytes: 661512704; Read time: 9; Write time: 1856 08:20:24 INFO - TinderboxPrint: CPU usage
53.4% 08:20:24 INFO - TinderboxPrint: I/O read bytes / time
1,490,944 / 9 08:20:24 INFO - TinderboxPrint: I/O write bytes / time
661,512,704 / 1,856 08:20:24 INFO - TinderboxPrint: CPU idle
2,254.4 (46.6%) 08:20:24 INFO - TinderboxPrint: CPU system
975.6 (20.2%) 08:20:24 INFO - TinderboxPrint: CPU user
1,611.7 (33.3%) 08:20:24 INFO - TinderboxPrint: Swap in / out
364,466,176 / 0 08:20:24 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 360475136; Write bytes: 356132352; Read time: 28556; Write time: 716 08:20:24 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 655360; Write bytes: 294317056; Read time: 7; Write time: 1101 08:20:24 INFO - Running post-run listener: _upload_blobber_files 08:20:24 INFO - Blob upload gear active. 08:20:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:20: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 08:20: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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:20: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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:20:25 INFO - (blobuploader) - INFO - Open directory for files ... 08:20:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:20:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:20:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:26 INFO - (blobuploader) - INFO - Done attempting. 08:20:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:20:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:20:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:27 INFO - (blobuploader) - INFO - Done attempting. 08:20:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:20:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:20:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:29 INFO - (blobuploader) - INFO - Done attempting. 08:20:29 INFO - (blobuploader) - INFO - Iteration through files over. 08:20:29 INFO - Return code: 0 08:20:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:20:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:20:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/039bf1fe35fed2a1a2b59f829f93946c4caa0e8072488d31ccdee711edb348bbebea29eb5ca66b69114fa1af6a00d2d8059ea7914ba7a01dd25aed912ac1157c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e2b154962cb59501a5cd63b1f65e0cafd4ecc678e27acb5bdf08468677d16eeeab1e3030e5db95d8346e286b56826109274c603d7ef77c21f861a346442e3c74", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f7f2267e4682fa87b63809fef6ab849032e214cd19fc75b187aa33006cce845fb6860ad6befaf9239f8405a549b50a723324810c0d6ccce9bf4c24513090b81f"} 08:20:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:20:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:20:29 INFO - Contents: 08:20:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/039bf1fe35fed2a1a2b59f829f93946c4caa0e8072488d31ccdee711edb348bbebea29eb5ca66b69114fa1af6a00d2d8059ea7914ba7a01dd25aed912ac1157c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e2b154962cb59501a5cd63b1f65e0cafd4ecc678e27acb5bdf08468677d16eeeab1e3030e5db95d8346e286b56826109274c603d7ef77c21f861a346442e3c74", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f7f2267e4682fa87b63809fef6ab849032e214cd19fc75b187aa33006cce845fb6860ad6befaf9239f8405a549b50a723324810c0d6ccce9bf4c24513090b81f"} 08:20:29 INFO - Running post-run listener: copy_logs_to_upload_dir 08:20:29 INFO - Copying logs to upload dir... 08:20:29 INFO - mkdir: /builds/slave/test/build/upload/logs 08:20:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.101058 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-10-29 08:20:29.535781) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-29 08:20:29.539751) ========= 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.SNzcGVdkLA/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.qcXlKpWcMc/Listeners TMPDIR=/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/039bf1fe35fed2a1a2b59f829f93946c4caa0e8072488d31ccdee711edb348bbebea29eb5ca66b69114fa1af6a00d2d8059ea7914ba7a01dd25aed912ac1157c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e2b154962cb59501a5cd63b1f65e0cafd4ecc678e27acb5bdf08468677d16eeeab1e3030e5db95d8346e286b56826109274c603d7ef77c21f861a346442e3c74", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f7f2267e4682fa87b63809fef6ab849032e214cd19fc75b187aa33006cce845fb6860ad6befaf9239f8405a549b50a723324810c0d6ccce9bf4c24513090b81f"} build_url:https://queue.taskcluster.net/v1/task/N673DChmTh6paGnkX3YjOw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011217 build_url: 'https://queue.taskcluster.net/v1/task/N673DChmTh6paGnkX3YjOw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/039bf1fe35fed2a1a2b59f829f93946c4caa0e8072488d31ccdee711edb348bbebea29eb5ca66b69114fa1af6a00d2d8059ea7914ba7a01dd25aed912ac1157c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e2b154962cb59501a5cd63b1f65e0cafd4ecc678e27acb5bdf08468677d16eeeab1e3030e5db95d8346e286b56826109274c603d7ef77c21f861a346442e3c74", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f7f2267e4682fa87b63809fef6ab849032e214cd19fc75b187aa33006cce845fb6860ad6befaf9239f8405a549b50a723324810c0d6ccce9bf4c24513090b81f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-29 08:20:29.574101) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 08:20:29.574519) ========= 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.SNzcGVdkLA/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.qcXlKpWcMc/Listeners TMPDIR=/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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.005261 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 08:20:29.623857) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-29 08:20:29.624165) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-29 08:20:29.624457) ========= ========= Total master_lag: 0.18 =========