builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0111 starttime: 1476141251.78 results: success (0) buildid: 20161010134823 builduid: 6d7717879aed42209ec7e105bb1dec8d revision: 944f5e3f8f87b09eeed9804cd9cf8283a93df213 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 16:14:11.778831) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 16:14:11.779700) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 16:14:11.780140) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 16:14:11.803380) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 16:14:11.803797) ========= 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.QiCeGehpDW/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.Wdhmi4sr35/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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-10 16:14:11-- 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% 8.19M=0.001s 2016-10-10 16:14:11 (8.19 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130713 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 16:14:11.956842) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 16:14:11.957224) ========= 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.QiCeGehpDW/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.Wdhmi4sr35/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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.020918 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 16:14:12.008065) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 16:14:12.008875) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 944f5e3f8f87b09eeed9804cd9cf8283a93df213 --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 944f5e3f8f87b09eeed9804cd9cf8283a93df213 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QiCeGehpDW/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.Wdhmi4sr35/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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-10 16:14:12,082 truncating revision to first 12 chars 2016-10-10 16:14:12,082 Setting DEBUG logging. 2016-10-10 16:14:12,082 attempt 1/10 2016-10-10 16:14:12,082 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/944f5e3f8f87?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-10 16:14:12,741 unpacking tar archive at: mozilla-aurora-944f5e3f8f87/testing/mozharness/ program finished with exit code 0 elapsedTime=0.920398 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 16:14:12.952505) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 16:14:12.953065) ========= script_repo_revision: 944f5e3f8f87b09eeed9804cd9cf8283a93df213 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 16:14:12.953522) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 16:14:12.953851) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 16:14:12.972492) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-10-10 16:14:12.972902) ========= /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.QiCeGehpDW/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.Wdhmi4sr35/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 16:14:13 INFO - MultiFileLogger online at 20161010 16:14:13 in /builds/slave/test 16:14:13 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 16:14:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:14:13 INFO - {'append_to_log': False, 16:14:13 INFO - 'base_work_dir': '/builds/slave/test', 16:14:13 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:14:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:14:13 INFO - 'branch': 'Mozilla-Aurora', 16:14:13 INFO - 'buildbot_json_path': 'buildprops.json', 16:14:13 INFO - 'config_files': ('talos/mac_config.py',), 16:14:13 INFO - 'default_actions': ('clobber', 16:14:13 INFO - 'read-buildbot-config', 16:14:13 INFO - 'download-and-extract', 16:14:13 INFO - 'populate-webroot', 16:14:13 INFO - 'create-virtualenv', 16:14:13 INFO - 'install', 16:14:13 INFO - 'run-tests'), 16:14:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:14:13 INFO - 'download_minidump_stackwalk': True, 16:14:13 INFO - 'download_symbols': 'ondemand', 16:14:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:14:13 INFO - 'tooltool.py': '/tools/tooltool.py', 16:14:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:14:13 INFO - '/tools/misc-python/virtualenv.py')}, 16:14:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:14:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:14:13 INFO - 'installer_path': 'installer.exe', 16:14:13 INFO - 'log_level': 'info', 16:14:13 INFO - 'log_name': 'talos', 16:14:13 INFO - 'log_to_console': True, 16:14:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:14:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:14:13 INFO - 'opt_config_files': (), 16:14:13 INFO - 'pip_index': False, 16:14:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:14:13 INFO - 'cmd': ('bash', 16:14:13 INFO - '-c', 16:14:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:14:13 INFO - 'enabled': True, 16:14:13 INFO - 'halt_on_failure': False, 16:14:13 INFO - 'name': 'check_screen_resolution'},), 16:14:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:14:13 INFO - 'cmd': ('bash', 16:14:13 INFO - '-c', 16:14:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:14:13 INFO - 'enabled': True, 16:14:13 INFO - 'halt_on_failure': False, 16:14:13 INFO - 'name': 'check_screen_resolution'},), 16:14:13 INFO - 'run_cmd_checks_enabled': True, 16:14:13 INFO - 'sps_profile': False, 16:14:13 INFO - 'sps_profile_interval': 0, 16:14:13 INFO - 'suite': 'dromaeojs', 16:14:13 INFO - 'system_bits': '32', 16:14:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:14:13 INFO - 'title': 't-yosemite-r7-0111', 16:14:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:14:13 INFO - 'use_talos_json': True, 16:14:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:14:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:14:13 INFO - 'work_dir': 'build'} 16:14:13 INFO - [mozharness: 2016-10-10 23:14:13.161677Z] Running clobber step. 16:14:13 INFO - Running pre-action listener: _resource_record_pre_action 16:14:13 INFO - Running main action method: clobber 16:14:13 INFO - rmtree: /builds/slave/test/build 16:14:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:14:14 INFO - Running post-action listener: _resource_record_post_action 16:14:14 INFO - [mozharness: 2016-10-10 23:14:14.983763Z] Finished clobber step (success) 16:14:14 INFO - [mozharness: 2016-10-10 23:14:14.983882Z] Running read-buildbot-config step. 16:14:14 INFO - Running pre-action listener: _resource_record_pre_action 16:14:14 INFO - Running main action method: read_buildbot_config 16:14:14 INFO - Using buildbot properties: 16:14:14 INFO - { 16:14:14 INFO - "project": "", 16:14:14 INFO - "product": "firefox", 16:14:14 INFO - "script_repo_revision": "production", 16:14:14 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 16:14:14 INFO - "repository": "", 16:14:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 16:14:14 INFO - "buildid": "20161010134823", 16:14:14 INFO - "pgo_build": "False", 16:14:14 INFO - "basedir": "/builds/slave/test", 16:14:14 INFO - "buildnumber": 45, 16:14:14 INFO - "slavename": "t-yosemite-r7-0111", 16:14:14 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 16:14:14 INFO - "platform": "yosemite_r7", 16:14:14 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 16:14:14 INFO - "branch": "mozilla-aurora", 16:14:14 INFO - "repo_path": "releases/mozilla-aurora", 16:14:14 INFO - "revision": "944f5e3f8f87b09eeed9804cd9cf8283a93df213", 16:14:14 INFO - "stage_platform": "macosx64", 16:14:14 INFO - "builduid": "6d7717879aed42209ec7e105bb1dec8d", 16:14:14 INFO - "slavebuilddir": "test" 16:14:14 INFO - } 16:14:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/VaSC_-k4SxepVVmsZlDq1w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 16:14:14 INFO - Running post-action listener: _resource_record_post_action 16:14:14 INFO - [mozharness: 2016-10-10 23:14:14.987111Z] Finished read-buildbot-config step (success) 16:14:14 INFO - [mozharness: 2016-10-10 23:14:14.987227Z] Running download-and-extract step. 16:14:14 INFO - Running pre-action listener: _resource_record_pre_action 16:14:14 INFO - Running main action method: download_and_extract 16:14:14 INFO - mkdir: /builds/slave/test/build/tests 16:14:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:14 INFO - trying https://queue.taskcluster.net/v1/task/VaSC_-k4SxepVVmsZlDq1w/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 16:14:14 INFO - Downloading https://queue.taskcluster.net/v1/task/VaSC_-k4SxepVVmsZlDq1w/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 16:14:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VaSC_-k4SxepVVmsZlDq1w/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 16:14:16 INFO - Downloaded 1199 bytes. 16:14:16 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 16:14:16 INFO - Using the following test package requirements: 16:14:16 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 16:14:16 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:14:16 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 16:14:16 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:14:16 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 16:14:16 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:14:16 INFO - u'jsshell-mac.zip'], 16:14:16 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:14:16 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 16:14:16 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 16:14:16 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:14:16 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 16:14:16 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:14:16 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 16:14:16 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:14:16 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 16:14:16 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:14:16 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 16:14:16 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 16:14:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VaSC_-k4SxepVVmsZlDq1w/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 16:14:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VaSC_-k4SxepVVmsZlDq1w/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:14:16 INFO - Fetch https://queue.taskcluster.net/v1/task/VaSC_-k4SxepVVmsZlDq1w/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 16:14:16 INFO - Expected file size: 16434708 16:14:23 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 16:14:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VaSC_-k4SxepVVmsZlDq1w/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 16:14:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VaSC_-k4SxepVVmsZlDq1w/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:14:23 INFO - Fetch https://queue.taskcluster.net/v1/task/VaSC_-k4SxepVVmsZlDq1w/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 16:14:24 INFO - Expected file size: 16434708 16:14:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VaSC_-k4SxepVVmsZlDq1w/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 16:14:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VaSC_-k4SxepVVmsZlDq1w/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 16:14:30 INFO - Fetch https://queue.taskcluster.net/v1/task/VaSC_-k4SxepVVmsZlDq1w/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 16:14:31 INFO - Expected file size: 14414059 16:14:32 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')]} 16:14:32 INFO - trying https://queue.taskcluster.net/v1/task/VaSC_-k4SxepVVmsZlDq1w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:14:32 INFO - Downloading https://queue.taskcluster.net/v1/task/VaSC_-k4SxepVVmsZlDq1w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 16:14:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VaSC_-k4SxepVVmsZlDq1w/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 16:14:35 INFO - Downloaded 115370805 bytes. 16:14:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VaSC_-k4SxepVVmsZlDq1w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:14:35 INFO - mkdir: /builds/slave/test/properties 16:14:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:14:35 INFO - Writing to file /builds/slave/test/properties/build_url 16:14:35 INFO - Contents: 16:14:35 INFO - build_url:https://queue.taskcluster.net/v1/task/VaSC_-k4SxepVVmsZlDq1w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:14:36 INFO - Running post-action listener: _resource_record_post_action 16:14:36 INFO - Running post-action listener: set_extra_try_arguments 16:14:36 INFO - [mozharness: 2016-10-10 23:14:36.028742Z] Finished download-and-extract step (success) 16:14:36 INFO - [mozharness: 2016-10-10 23:14:36.028858Z] Running populate-webroot step. 16:14:36 INFO - Running pre-action listener: _resource_record_pre_action 16:14:36 INFO - Running main action method: populate_webroot 16:14:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:14:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:14:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:14:36 INFO - '--tppagecycles', 16:14:36 INFO - '7'], 16:14:36 INFO - 'tests': ['tsvgm']}}, 16:14:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:14:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:14:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:14:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:14:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:14:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:14:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:36 INFO - 'talos_options': ['--disable-e10s'], 16:14:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:14:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:14:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:36 INFO - 'talos_options': ['--disable-e10s'], 16:14:36 INFO - 'tests': ['damp', 'tps']}, 16:14:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:36 INFO - 'tests': ['damp', 'tps']}, 16:14:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:14:36 INFO - 'tests': ['dromaeo_dom']}, 16:14:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:14:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:14:36 INFO - 'tests': ['basic_compositor_video']}, 16:14:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:14:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:14:36 INFO - 'tests': ['a11yr', 16:14:36 INFO - 'ts_paint', 16:14:36 INFO - 'tpaint', 16:14:36 INFO - 'sessionrestore', 16:14:36 INFO - 'sessionrestore_no_auto_restore', 16:14:36 INFO - 'tabpaint']}, 16:14:36 INFO - 'other-e10s': {'tests': ['a11yr', 16:14:36 INFO - 'ts_paint', 16:14:36 INFO - 'tpaint', 16:14:36 INFO - 'sessionrestore', 16:14:36 INFO - 'sessionrestore_no_auto_restore', 16:14:36 INFO - 'tabpaint']}, 16:14:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:14:36 INFO - 'ts_paint', 16:14:36 INFO - 'tpaint', 16:14:36 INFO - 'sessionrestore', 16:14:36 INFO - 'sessionrestore_no_auto_restore', 16:14:36 INFO - 'tabpaint']}, 16:14:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:14:36 INFO - 'ts_paint', 16:14:36 INFO - 'tpaint', 16:14:36 INFO - 'sessionrestore', 16:14:36 INFO - 'sessionrestore_no_auto_restore', 16:14:36 INFO - 'tabpaint']}, 16:14:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:14:36 INFO - 'tests': ['a11yr', 16:14:36 INFO - 'ts_paint', 16:14:36 INFO - 'tpaint', 16:14:36 INFO - 'sessionrestore', 16:14:36 INFO - 'sessionrestore_no_auto_restore', 16:14:36 INFO - 'tabpaint']}, 16:14:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:14:36 INFO - 'tests': ['a11yr', 16:14:36 INFO - 'ts_paint', 16:14:36 INFO - 'tpaint', 16:14:36 INFO - 'sessionrestore', 16:14:36 INFO - 'sessionrestore_no_auto_restore', 16:14:36 INFO - 'tabpaint']}, 16:14:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:14:36 INFO - 'tests': ['tsvgx', 16:14:36 INFO - 'tsvgr_opacity', 16:14:36 INFO - 'tart', 16:14:36 INFO - 'tscrollx', 16:14:36 INFO - 'cart']}, 16:14:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:14:36 INFO - 'tsvgr_opacity', 16:14:36 INFO - 'tart', 16:14:36 INFO - 'tscrollx', 16:14:36 INFO - 'cart']}, 16:14:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:36 INFO - 'talos_options': ['--disable-e10s'], 16:14:36 INFO - 'tests': ['tp5o']}, 16:14:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:36 INFO - 'tests': ['tp5o']}, 16:14:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:36 INFO - 'talos_options': ['--disable-e10s', 16:14:36 INFO - '--xperf_path', 16:14:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:14:36 INFO - 'tests': ['tp5n']}, 16:14:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:36 INFO - 'talos_options': ['--xperf_path', 16:14:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:14:36 INFO - 'tests': ['tp5n']}}, 16:14:36 INFO - 'talos.zip': {'path': '', 16:14:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:14:36 INFO - Running post-action listener: _resource_record_post_action 16:14:36 INFO - [mozharness: 2016-10-10 23:14:36.047237Z] Finished populate-webroot step (success) 16:14:36 INFO - [mozharness: 2016-10-10 23:14:36.047350Z] Running create-virtualenv step. 16:14:36 INFO - Running pre-action listener: _resource_record_pre_action 16:14:36 INFO - Running main action method: create_virtualenv 16:14:36 INFO - Creating virtualenv /builds/slave/test/build/venv 16:14:36 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 16:14:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:14:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:14:36 INFO - Using real prefix '/tools/python27' 16:14:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:14:36 INFO - Installing distribute.............................................................................................................................................................................................done. 16:14:39 INFO - Installing pip.................done. 16:14:39 INFO - Return code: 0 16:14:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:14:39 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')]} 16:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:39 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')]} 16:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:39 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 0x102ec6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e3c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fba59fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cdad30>, '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 0x102b40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102cd2b20>, '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.QiCeGehpDW/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.Wdhmi4sr35/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 16:14:39 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 16:14:39 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 16:14:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiCeGehpDW/Render', 16:14:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:14:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:14:39 INFO - 'HOME': '/Users/cltbld', 16:14:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:14:39 INFO - 'LOGNAME': 'cltbld', 16:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:39 INFO - 'MOZ_NO_REMOTE': '1', 16:14:39 INFO - 'NO_EM_RESTART': '1', 16:14:39 INFO - 'PAGER': '/bin/cat', 16:14:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:39 INFO - 'PWD': '/builds/slave/test', 16:14:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:14:39 INFO - 'SHELL': '/bin/bash', 16:14:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wdhmi4sr35/Listeners', 16:14:39 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 16:14:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:14:39 INFO - 'USER': 'cltbld', 16:14:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:14:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:39 INFO - 'XPC_FLAGS': '0x0', 16:14:39 INFO - 'XPC_SERVICE_NAME': '0', 16:14:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:39 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 16:14:39 INFO - Cleaning up... 16:14:40 INFO - Return code: 0 16:14:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:40 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 0x102ec6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e3c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fba59fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cdad30>, '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 0x102b40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102cd2b20>, '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.QiCeGehpDW/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.Wdhmi4sr35/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 16:14:40 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 16:14:40 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 16:14:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiCeGehpDW/Render', 16:14:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:14:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:14:40 INFO - 'HOME': '/Users/cltbld', 16:14:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:14:40 INFO - 'LOGNAME': 'cltbld', 16:14:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:40 INFO - 'MOZ_NO_REMOTE': '1', 16:14:40 INFO - 'NO_EM_RESTART': '1', 16:14:40 INFO - 'PAGER': '/bin/cat', 16:14:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:14:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:40 INFO - 'PWD': '/builds/slave/test', 16:14:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:14:40 INFO - 'SHELL': '/bin/bash', 16:14:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wdhmi4sr35/Listeners', 16:14:40 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 16:14:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:14:40 INFO - 'USER': 'cltbld', 16:14:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:14:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:14:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:40 INFO - 'XPC_FLAGS': '0x0', 16:14:40 INFO - 'XPC_SERVICE_NAME': '0', 16:14:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:14:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:40 INFO - Downloading/unpacking psutil>=3.1.1 16:14:40 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 16:14:40 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 16:14:40 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 16:14:40 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 16:14:40 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 16:14:40 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 16:14:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:14:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:14:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:14:43 INFO - Installing collected packages: psutil 16:14:43 INFO - Running setup.py install for psutil 16:14:43 INFO - building 'psutil._psutil_osx' extension 16:14:43 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 16:14:44 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 16:14:44 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 16:14:44 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 16:14:44 INFO - building 'psutil._psutil_posix' extension 16:14:44 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 16:14:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:14:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:14:44 INFO - ^ 16:14:44 INFO - 1 warning generated. 16:14:44 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 16:14:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:14:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:14:44 INFO - Successfully installed psutil 16:14:44 INFO - Cleaning up... 16:14:44 INFO - Return code: 0 16:14:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:44 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 0x102ec6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e3c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fba59fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cdad30>, '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 0x102b40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102cd2b20>, '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.QiCeGehpDW/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.Wdhmi4sr35/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 16:14:44 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 16:14:44 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 16:14:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiCeGehpDW/Render', 16:14:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:14:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:14:44 INFO - 'HOME': '/Users/cltbld', 16:14:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:14:44 INFO - 'LOGNAME': 'cltbld', 16:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:44 INFO - 'MOZ_NO_REMOTE': '1', 16:14:44 INFO - 'NO_EM_RESTART': '1', 16:14:44 INFO - 'PAGER': '/bin/cat', 16:14:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:44 INFO - 'PWD': '/builds/slave/test', 16:14:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:14:44 INFO - 'SHELL': '/bin/bash', 16:14:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wdhmi4sr35/Listeners', 16:14:44 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 16:14:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:14:44 INFO - 'USER': 'cltbld', 16:14:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:14:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:44 INFO - 'XPC_FLAGS': '0x0', 16:14:44 INFO - 'XPC_SERVICE_NAME': '0', 16:14:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:14:44 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 16:14:44 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 16:14:44 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 16:14:44 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 16:14:44 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 16:14:44 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 16:14:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:14:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:14:47 INFO - Installing collected packages: mozsystemmonitor 16:14:47 INFO - Running setup.py install for mozsystemmonitor 16:14:47 INFO - Successfully installed mozsystemmonitor 16:14:47 INFO - Cleaning up... 16:14:47 INFO - Return code: 0 16:14:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102ec6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e3c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fba59fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cdad30>, '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 0x102b40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102cd2b20>, '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.QiCeGehpDW/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.Wdhmi4sr35/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 16:14:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:14:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:14:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiCeGehpDW/Render', 16:14:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:14:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:14:47 INFO - 'HOME': '/Users/cltbld', 16:14:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:14:47 INFO - 'LOGNAME': 'cltbld', 16:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:47 INFO - 'MOZ_NO_REMOTE': '1', 16:14:47 INFO - 'NO_EM_RESTART': '1', 16:14:47 INFO - 'PAGER': '/bin/cat', 16:14:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:47 INFO - 'PWD': '/builds/slave/test', 16:14:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:14:47 INFO - 'SHELL': '/bin/bash', 16:14:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wdhmi4sr35/Listeners', 16:14:47 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 16:14:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:14:47 INFO - 'USER': 'cltbld', 16:14:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:14:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:47 INFO - 'XPC_FLAGS': '0x0', 16:14:47 INFO - 'XPC_SERVICE_NAME': '0', 16:14:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:47 INFO - Downloading/unpacking jsonschema==2.5.1 16:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:14:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:50 INFO - Downloading functools32-3.2.3-2.tar.gz 16:14:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:14:50 INFO - warning: no files found matching '*.txt' 16:14:50 INFO - no previously-included directories found matching 'build' 16:14:50 INFO - no previously-included directories found matching 'dist' 16:14:50 INFO - no previously-included directories found matching '.git*' 16:14:50 INFO - Installing collected packages: jsonschema, functools32 16:14:50 INFO - Running setup.py install for functools32 16:14:50 INFO - warning: no files found matching '*.txt' 16:14:50 INFO - no previously-included directories found matching 'build' 16:14:50 INFO - no previously-included directories found matching 'dist' 16:14:50 INFO - no previously-included directories found matching '.git*' 16:14:50 INFO - Successfully installed jsonschema functools32 16:14:50 INFO - Cleaning up... 16:14:51 INFO - Return code: 0 16:14:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:14:51 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')]} 16:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:51 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')]} 16:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:51 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 0x102ec6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e3c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fba59fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cdad30>, '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 0x102b40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102cd2b20>, '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.QiCeGehpDW/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.Wdhmi4sr35/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 16:14:51 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 16:14:51 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 16:14:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiCeGehpDW/Render', 16:14:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:14:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:14:51 INFO - 'HOME': '/Users/cltbld', 16:14:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:14:51 INFO - 'LOGNAME': 'cltbld', 16:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:51 INFO - 'MOZ_NO_REMOTE': '1', 16:14:51 INFO - 'NO_EM_RESTART': '1', 16:14:51 INFO - 'PAGER': '/bin/cat', 16:14:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:51 INFO - 'PWD': '/builds/slave/test', 16:14:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:14:51 INFO - 'SHELL': '/bin/bash', 16:14:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wdhmi4sr35/Listeners', 16:14:51 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 16:14:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:14:51 INFO - 'USER': 'cltbld', 16:14:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:14:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:51 INFO - 'XPC_FLAGS': '0x0', 16:14:51 INFO - 'XPC_SERVICE_NAME': '0', 16:14:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:14:51 INFO - Cleaning up... 16:14:51 INFO - Return code: 0 16:14:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:14:51 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')]} 16:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:51 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')]} 16:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:51 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 0x102ec6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e3c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fba59fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cdad30>, '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 0x102b40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102cd2b20>, '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.QiCeGehpDW/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.Wdhmi4sr35/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 16:14:51 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 16:14:51 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 16:14:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiCeGehpDW/Render', 16:14:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:14:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:14:51 INFO - 'HOME': '/Users/cltbld', 16:14:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:14:51 INFO - 'LOGNAME': 'cltbld', 16:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:51 INFO - 'MOZ_NO_REMOTE': '1', 16:14:51 INFO - 'NO_EM_RESTART': '1', 16:14:51 INFO - 'PAGER': '/bin/cat', 16:14:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:51 INFO - 'PWD': '/builds/slave/test', 16:14:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:14:51 INFO - 'SHELL': '/bin/bash', 16:14:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wdhmi4sr35/Listeners', 16:14:51 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 16:14:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:14:51 INFO - 'USER': 'cltbld', 16:14:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:14:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:51 INFO - 'XPC_FLAGS': '0x0', 16:14:51 INFO - 'XPC_SERVICE_NAME': '0', 16:14:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:51 INFO - Downloading/unpacking blobuploader==1.2.4 16:14: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 16:14: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 16:14: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 16:14: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 16:14: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 16:14: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 16:14:54 INFO - Downloading blobuploader-1.2.4.tar.gz 16:14:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:14:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:14: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 16:14: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 16:14: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 16:14: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 16:14: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 16:14: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 16:14:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:14:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:14: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 16:14: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 16:14: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 16:14: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 16:14: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 16:14: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 16:14:55 INFO - Downloading docopt-0.6.1.tar.gz 16:14:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:14:55 INFO - Installing collected packages: blobuploader, requests, docopt 16:14:55 INFO - Running setup.py install for blobuploader 16:14:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:14:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:14:55 INFO - Running setup.py install for requests 16:14:55 INFO - Running setup.py install for docopt 16:14:56 INFO - Successfully installed blobuploader requests docopt 16:14:56 INFO - Cleaning up... 16:14:56 INFO - Return code: 0 16:14:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:56 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 0x102ec6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e3c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fba59fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cdad30>, '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 0x102b40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102cd2b20>, '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.QiCeGehpDW/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.Wdhmi4sr35/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 16:14:56 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 16:14:56 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 16:14:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiCeGehpDW/Render', 16:14:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:14:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:14:56 INFO - 'HOME': '/Users/cltbld', 16:14:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:14:56 INFO - 'LOGNAME': 'cltbld', 16:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:56 INFO - 'MOZ_NO_REMOTE': '1', 16:14:56 INFO - 'NO_EM_RESTART': '1', 16:14:56 INFO - 'PAGER': '/bin/cat', 16:14:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:56 INFO - 'PWD': '/builds/slave/test', 16:14:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:14:56 INFO - 'SHELL': '/bin/bash', 16:14:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wdhmi4sr35/Listeners', 16:14:56 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 16:14:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:14:56 INFO - 'USER': 'cltbld', 16:14:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:14:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:56 INFO - 'XPC_FLAGS': '0x0', 16:14:56 INFO - 'XPC_SERVICE_NAME': '0', 16:14:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:14:56 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-IL9blM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:14:56 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-DdkbA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:14:56 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-zuWFPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:14:56 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-v0d4R6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:14:56 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-HP4EGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:14:56 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-K_RMNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:14:57 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-u0jPRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:14:57 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-nT9S8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:14:57 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-0bv548-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:14:57 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-3aO6zT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:14:57 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-2d4Yxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:14:57 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-OAvgZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:14:57 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-ARkxKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:14:57 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-C07mpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:14:57 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-QyhOBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:14:58 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-J8OiWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:14:58 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-b92nGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:14:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:14:58 INFO - Running setup.py install for manifestparser 16:14:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:14:58 INFO - Running setup.py install for mozcrash 16:14:58 INFO - Running setup.py install for mozdebug 16:14:58 INFO - Running setup.py install for mozdevice 16:14:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:14:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:14:58 INFO - Running setup.py install for mozfile 16:14:58 INFO - Running setup.py install for mozhttpd 16:14:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:14:59 INFO - Running setup.py install for mozinfo 16:14:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:14:59 INFO - Running setup.py install for mozInstall 16:14:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:14:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:14:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:14:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:14:59 INFO - Running setup.py install for mozleak 16:14:59 INFO - Running setup.py install for mozlog 16:14:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:14:59 INFO - Running setup.py install for moznetwork 16:14:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:14:59 INFO - Running setup.py install for mozprocess 16:15:00 INFO - Running setup.py install for mozprofile 16:15:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:15:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:15:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:15:00 INFO - Running setup.py install for mozrunner 16:15:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:15:00 INFO - Running setup.py install for mozscreenshot 16:15:00 INFO - Running setup.py install for moztest 16:15:00 INFO - Running setup.py install for mozversion 16:15:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:15:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:15:00 INFO - Cleaning up... 16:15:00 INFO - Return code: 0 16:15:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102ec6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e3c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fba59fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cdad30>, '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 0x102b40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102cd2b20>, '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.QiCeGehpDW/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.Wdhmi4sr35/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 16:15:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:15:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:15:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiCeGehpDW/Render', 16:15:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:15:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:15:00 INFO - 'HOME': '/Users/cltbld', 16:15:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:15:00 INFO - 'LOGNAME': 'cltbld', 16:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:00 INFO - 'MOZ_NO_REMOTE': '1', 16:15:00 INFO - 'NO_EM_RESTART': '1', 16:15:00 INFO - 'PAGER': '/bin/cat', 16:15:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:00 INFO - 'PWD': '/builds/slave/test', 16:15:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:15:00 INFO - 'SHELL': '/bin/bash', 16:15:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wdhmi4sr35/Listeners', 16:15:00 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 16:15:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:15:00 INFO - 'USER': 'cltbld', 16:15:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:15:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:00 INFO - 'XPC_FLAGS': '0x0', 16:15:00 INFO - 'XPC_SERVICE_NAME': '0', 16:15:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:15:01 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-1b1322-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:15:01 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)) 16:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:15:01 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-hADmTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:15:01 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)) 16:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:15:01 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-Q10_T2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:15:01 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)) 16:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:15:01 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-89HFNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:15:01 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)) 16:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:15:01 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-FnA1oR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:15:01 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)) 16:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:15:01 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-zST48k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:15:01 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)) 16:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:15:01 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-SbVvG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:15:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:15:01 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-OTMy1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:15:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:15:01 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-Or3B9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:15:02 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)) 16:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:15:02 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-rDQOgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:15:02 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)) 16:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:15:02 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-N6_UDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:15:02 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)) 16:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:15:02 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-8AOhcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:15:02 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)) 16:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:15:02 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-wWlRg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:15:02 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)) 16:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:15:02 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-cl5Xm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:15:02 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)) 16:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:15:02 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-1lAmOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:15:02 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)) 16:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:15:02 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-bHGVf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:15:02 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)) 16:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:15:02 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-qt_eud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:15:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:05 INFO - Downloading blessings-1.6.tar.gz 16:15:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:15:05 INFO - Installing collected packages: blessings 16:15:05 INFO - Running setup.py install for blessings 16:15:05 INFO - Successfully installed blessings 16:15:05 INFO - Cleaning up... 16:15:05 INFO - Return code: 0 16:15:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:15:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:15:06 INFO - Reading from file tmpfile_stdout 16:15:06 INFO - Current package versions: 16:15:06 INFO - blessings == 1.6 16:15:06 INFO - blobuploader == 1.2.4 16:15:06 INFO - docopt == 0.6.1 16:15:06 INFO - functools32 == 3.2.3-2 16:15:06 INFO - jsonschema == 2.5.1 16:15:06 INFO - manifestparser == 1.1 16:15:06 INFO - mozInstall == 1.12 16:15:06 INFO - mozcrash == 0.17 16:15:06 INFO - mozdebug == 0.1 16:15:06 INFO - mozdevice == 0.48 16:15:06 INFO - mozfile == 1.2 16:15:06 INFO - mozhttpd == 0.7 16:15:06 INFO - mozinfo == 0.9 16:15:06 INFO - mozleak == 0.1 16:15:06 INFO - mozlog == 3.4 16:15:06 INFO - moznetwork == 0.27 16:15:06 INFO - mozprocess == 0.23 16:15:06 INFO - mozprofile == 0.28 16:15:06 INFO - mozrunner == 6.12 16:15:06 INFO - mozscreenshot == 0.1 16:15:06 INFO - mozsystemmonitor == 0.3 16:15:06 INFO - moztest == 0.7 16:15:06 INFO - mozversion == 1.4 16:15:06 INFO - psutil == 3.1.1 16:15:06 INFO - requests == 1.2.3 16:15:06 INFO - wsgiref == 0.1.2 16:15:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:06 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 0x102ec6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e3c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fba59fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cdad30>, '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 0x102b40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102cd2b20>, '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.QiCeGehpDW/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.Wdhmi4sr35/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 16:15:06 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 16:15:06 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 16:15:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiCeGehpDW/Render', 16:15:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:15:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:15:06 INFO - 'HOME': '/Users/cltbld', 16:15:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:15:06 INFO - 'LOGNAME': 'cltbld', 16:15:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:06 INFO - 'MOZ_NO_REMOTE': '1', 16:15:06 INFO - 'NO_EM_RESTART': '1', 16:15:06 INFO - 'PAGER': '/bin/cat', 16:15:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:15:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:06 INFO - 'PWD': '/builds/slave/test', 16:15:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:15:06 INFO - 'SHELL': '/bin/bash', 16:15:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wdhmi4sr35/Listeners', 16:15:06 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 16:15:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:15:06 INFO - 'USER': 'cltbld', 16:15:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:15:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:15:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:06 INFO - 'XPC_FLAGS': '0x0', 16:15:06 INFO - 'XPC_SERVICE_NAME': '0', 16:15:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:15:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:15:06 INFO - Cleaning up... 16:15:06 INFO - Return code: 0 16:15:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102ec6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e3c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fba59fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102cdad30>, '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 0x102b40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102cd2b20>, '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.QiCeGehpDW/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.Wdhmi4sr35/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 16:15:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:15:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiCeGehpDW/Render', 16:15:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:15:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:15:06 INFO - 'HOME': '/Users/cltbld', 16:15:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:15:06 INFO - 'LOGNAME': 'cltbld', 16:15:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:06 INFO - 'MOZ_NO_REMOTE': '1', 16:15:06 INFO - 'NO_EM_RESTART': '1', 16:15:06 INFO - 'PAGER': '/bin/cat', 16:15:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:15:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:06 INFO - 'PWD': '/builds/slave/test', 16:15:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:15:06 INFO - 'SHELL': '/bin/bash', 16:15:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wdhmi4sr35/Listeners', 16:15:06 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 16:15:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:15:06 INFO - 'USER': 'cltbld', 16:15:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:15:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:15:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:06 INFO - 'XPC_FLAGS': '0x0', 16:15:06 INFO - 'XPC_SERVICE_NAME': '0', 16:15:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:15:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:15:06 INFO - Cleaning up... 16:15:06 INFO - Return code: 0 16:15:06 INFO - Running post-action listener: _resource_record_post_action 16:15:06 INFO - Running post-action listener: _start_resource_monitoring 16:15:06 INFO - Starting resource monitoring. 16:15:06 INFO - [mozharness: 2016-10-10 23:15:06.714919Z] Finished create-virtualenv step (success) 16:15:06 INFO - [mozharness: 2016-10-10 23:15:06.715947Z] Running install step. 16:15:06 INFO - Running pre-action listener: _resource_record_pre_action 16:15:06 INFO - Running main action method: install 16:15:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:15:06 INFO - Reading from file tmpfile_stdout 16:15:06 INFO - Detecting whether we're running mozinstall >=1.0... 16:15:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:15:07 INFO - Reading from file tmpfile_stdout 16:15:07 INFO - Output received: 16:15:07 INFO - Usage: mozinstall [options] installer 16:15:07 INFO - Options: 16:15:07 INFO - -h, --help show this help message and exit 16:15:07 INFO - -d DEST, --destination=DEST 16:15:07 INFO - Directory to install application into. [default: 16:15:07 INFO - "/builds/slave/test"] 16:15:07 INFO - --app=APP Application being installed. [default: firefox] 16:15:07 INFO - mkdir: /builds/slave/test/build/application 16:15:07 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'] 16:15:07 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 16:15:38 INFO - Reading from file tmpfile_stdout 16:15:38 INFO - Output received: 16:15:38 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 16:15:38 INFO - Running post-action listener: _resource_record_post_action 16:15:38 INFO - [mozharness: 2016-10-10 23:15:38.960862Z] Finished install step (success) 16:15:38 INFO - [mozharness: 2016-10-10 23:15:38.961005Z] Running run-tests step. 16:15:38 INFO - Running pre-action listener: _resource_record_pre_action 16:15:38 INFO - Running main action method: run_tests 16:15:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:15:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:15:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:15:38 INFO - 2016-10-10 16:15:38.975 screenresolution[2291:21854] starting screenresolution argv=screenresolution get 16:15:38 INFO - 2016-10-10 16:15:38.978 screenresolution[2291:21854] Display 0: 1600x1200x32@60 16:15:38 INFO - 2016-10-10 16:15:38.984 screenresolution[2292:21856] starting screenresolution argv=screenresolution list 16:15:38 INFO - Available Modes on Display 0 16:15:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:15:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:15:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:15:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:15:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:15:39 INFO - Intel Iris: 16:15:39 INFO - Chipset Model: Intel Iris 16:15:39 INFO - Type: GPU 16:15:39 INFO - Bus: Built-In 16:15:39 INFO - VRAM (Dynamic, Max): 1536 MB 16:15:39 INFO - Vendor: Intel (0x8086) 16:15:39 INFO - Device ID: 0x0a2e 16:15:39 INFO - Revision ID: 0x0009 16:15:39 INFO - Displays: 16:15:39 INFO - Display: 16:15:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:15:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:15:39 INFO - Display Serial Number: 1600x1200 60 16:15:39 INFO - Main Display: Yes 16:15:39 INFO - Mirror: Off 16:15:39 INFO - Online: Yes 16:15:39 INFO - Rotation: Supported 16:15:39 INFO - Return code: 0 16:15:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:15:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:15:39 INFO - Python 2.7.3 16:15:39 INFO - Return code: 0 16:15:39 INFO - grabbing minidump binary from tooltool 16:15:39 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')]} 16:15:39 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 0x102cdad30>, '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 0x102b40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102cd2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:15:39 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 16:15:39 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 16:15:39 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 16:15:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:15:39 INFO - Return code: 0 16:15:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:15:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:15:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:15:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:15:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:15:39 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/VaSC_-k4SxepVVmsZlDq1w/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0111', '--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 16:15:39 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/VaSC_-k4SxepVVmsZlDq1w/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0111 --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 16:15:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiCeGehpDW/Render', 16:15:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:15:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:15:39 INFO - 'HOME': '/Users/cltbld', 16:15:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:15:39 INFO - 'LOGNAME': 'cltbld', 16:15:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:15:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:39 INFO - 'MOZ_NO_REMOTE': '1', 16:15:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:15:39 INFO - 'NO_EM_RESTART': '1', 16:15:39 INFO - 'PAGER': '/bin/cat', 16:15:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:39 INFO - 'PWD': '/builds/slave/test', 16:15:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:15:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:15:39 INFO - 'SHELL': '/bin/bash', 16:15:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Wdhmi4sr35/Listeners', 16:15:39 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 16:15:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:15:39 INFO - 'USER': 'cltbld', 16:15:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:15:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:39 INFO - 'XPC_FLAGS': '0x0', 16:15:39 INFO - 'XPC_SERVICE_NAME': '0', 16:15:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:15:39 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/VaSC_-k4SxepVVmsZlDq1w/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0111', '--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 16:15:39 INFO - mozversion application_buildid: 20161010134823 16:15:39 INFO - mozversion application_changeset: 944f5e3f8f87b09eeed9804cd9cf8283a93df213 16:15:39 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:15:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:15:39 INFO - mozversion application_name: Firefox 16:15:39 INFO - mozversion application_remotingname: firefox-dev 16:15:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:15:39 INFO - mozversion application_vendor: Mozilla 16:15:39 INFO - mozversion application_version: 51.0a2 16:15:39 INFO - mozversion platform_buildid: 20161010134823 16:15:39 INFO - mozversion platform_changeset: 944f5e3f8f87b09eeed9804cd9cf8283a93df213 16:15:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:15:39 INFO - mozversion platform_version: 51.0a2 16:15:39 INFO - using testdate: 1476141339 16:15:39 INFO - actual date: 1476141339 16:15:39 INFO - starting webserver on 'localhost:53005' 16:15:39 INFO - SUITE-START | Running 2 tests 16:15:39 INFO - TEST-START | dromaeo_css 16:15:39 INFO - operating with platform_type : mac_ 16:15:39 INFO - Initialising browser for dromaeo_css test... 16:15:39 INFO - TEST-INFO | started process 2302 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmp_Y5ABr/profile http://localhost:53005/getInfo.html) 16:15:41 INFO - PROCESS | 2302 | __metrics Screen width/height:1600/1200 16:15:41 INFO - PROCESS | 2302 | colorDepth:24 16:15:41 INFO - PROCESS | 2302 | Browser inner width/height: 1024/689 16:15:41 INFO - PROCESS | 2302 | __metrics 16:15:42 INFO - PROCESS | 2302 | 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" 16:15:42 INFO - PROCESS | 2302 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:15:42 INFO - TEST-INFO | 2302: exit 0 16:15:42 INFO - Browser initialized. 16:15:42 INFO - Running cycle 1/1 for dromaeo_css test... 16:15:42 INFO - TEST-INFO | started process 2304 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmp_Y5ABr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:15:54 INFO - PROCESS | 2304 | RSS: Main: 219324416 16:15:54 INFO - PROCESS | 2304 | 16:16:45 INFO - PROCESS | 2304 | 1476141405607 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] 16:18:57 INFO - PROCESS | 2304 | Cycle 1(1): loaded http://localhost:53005/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53005/tests/dromaeo/cssquery-ext.html) 16:18:58 INFO - PROCESS | 2304 | RSS: Main: 344961024 16:18:58 INFO - PROCESS | 2304 | 16:22:01 INFO - PROCESS | 2304 | Cycle 1(1): loaded http://localhost:53005/tests/dromaeo/cssquery-ext.html (next: http://localhost:53005/tests/dromaeo/cssquery-jquery.html) 16:22:02 INFO - PROCESS | 2304 | RSS: Main: 352710656 16:22:02 INFO - PROCESS | 2304 | 16:25:04 INFO - PROCESS | 2304 | Cycle 1(1): loaded http://localhost:53005/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53005/tests/dromaeo/cssquery-mootools.html) 16:25:05 INFO - PROCESS | 2304 | RSS: Main: 323280896 16:25:05 INFO - PROCESS | 2304 | 16:28:07 INFO - PROCESS | 2304 | Cycle 1(1): loaded http://localhost:53005/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53005/tests/dromaeo/cssquery-prototype.html) 16:28:08 INFO - PROCESS | 2304 | RSS: Main: 318808064 16:28:08 INFO - PROCESS | 2304 | 16:31:11 INFO - PROCESS | 2304 | Cycle 1(1): loaded http://localhost:53005/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53005/tests/dromaeo/cssquery-yui.html) 16:31:11 INFO - PROCESS | 2304 | RSS: Main: 311369728 16:31:11 INFO - PROCESS | 2304 | 16:34:14 INFO - PROCESS | 2304 | Cycle 1(1): loaded http://localhost:53005/tests/dromaeo/cssquery-yui.html (next: http://localhost:53005/tests/dromaeo/cssquery-dojo.html) 16:34:15 INFO - PROCESS | 2304 | RSS: Main: 378155008 16:34:15 INFO - PROCESS | 2304 | 16:34:15 INFO - PROCESS | 2304 | __start_tp_report 16:34:15 INFO - PROCESS | 2304 | _x_x_mozilla_page_load 16:34:15 INFO - PROCESS | 2304 | _x_x_mozilla_page_load_details 16:34:15 INFO - PROCESS | 2304 | |i|pagename|runs| 16:34:15 INFO - PROCESS | 2304 | |0;dojo.html;3293.703566678999;3295.209149804047;3337.5494308268376;3342.064222017836;3376.797392156471;5717.485426311631;5777.480026797587;5779.335376431712;5780.9132863007035;5793.565482588807;5649.322081350233;5738.42615738426;5751.281089863767;5752.7986520471795;5763;4342.3052311630145;5182.3262975813095;5217.47825217479;5224.981128679909;5236.7905283788605;5164.6384753067305;5176.120059589879;5190;5305.495977882095;5345.198220266952;5201.141811601081;5210.895782084356;5233.973830130844;5249.291345668324;5260.316158899338;5224.294720212761;5250.894982100336;5286.04851126797;5287.920681189786;5313.707746073965;4622.14490319292;5060.924086138711;5126.71803050832;5228.111221092423;5256.421793602701;5530.778768849241;5544.500994910437;5546.4453554644615;5600.663960162363;5648.435156484319;5435.537979271727;6238.9376106238815;6272.1219029335925;6277.87444251117;6302.684865756693;6275.560710750249;6277.717502712343;6324.33594472583;6342.175517182783;6342.809715708536;5626.606137570372;5669.773209071591;5689.687067211343;5734.541236701054;5795.7971470999155;6327.810165695037;6336.58812177207;6356.269029061717;6364.045393191059;6375.553711240262;6034.034554471264;6163.9383606164265;6164.229471316085;6175.907361389583;6191.288001879841;6104.701693046543;6127.189528148541;6156.78451254204;6305.243370795442;6320.810375688737;6118.3755344619085;6218.906716399258;6221.5333849961435;6237;6256.124142620037;6224;6224.875502489925;6236.532260080512;6240.937590624127;6248.781292654735;4793.592544633745;4858.46556878743;4865.489123642037;4911.557959783565;4913.459519452857;4369.890752731144;4440.689151759346;4441;4452.844150454718;4457.398251236042;5383.461653834585;5392.649477783932;5397.946020539823;5399.136138217867;5403.756830942617;6152.846178845564;6238;6242.375762423812;6249.875022495994;6259.0924315973925;5393.919091213635;5445.047116754631;5459.935312614081;5464.153056276284;5491.505764481216;5169.405518365361;5201.817936372209;5318.335208098988;5341.973290133602;5365.892682146336;6240.875182496325;6303.212098487689;6319;6330.620162790247;6330.651814150174;6245.469135123383;6267.561270711007;6270.655113968775;6271.404216599598;6285.088662143872;6286.74853005893;6303.558750887394;6313.589616674902;6316.052592111037;6329.2404911409085;5908.113782932594;5931.3178984417345;5962;6009.639421634716;6063.029915213545;6193.876122477435;6193.907091393543;6200.162977997912;6212.658303793335;6223.0354295084335;5274.314339135888;5823.534117270693;5919.437653422918;5968.134620479919;6017.909731353946;5765.596408251382;5819.418058194146;5872.354041055566;5951.226340575698;5958.225430693982;5708.828735137952;5766.798162064308;5769.59612827098;5794.82615521535;5873.148393483007;5941.554383421174;5945.970270148621;5948.821535353946;5953.732082056231;5960.403959604005;5752.654840709571;5760.366359700346;5783.421657834183;5801.274840644919;5818.534517238695 16:34:15 INFO - PROCESS | 2304 | |1;ext.html;475.0783480048705;477.23642172523967;480.61550759392475;506.97972081116745;520.6563667979135;29849.850750746242;39510;40858.97852553688;41011.17977640449;43473.565264347344;42595.57404425955;42999.3550096748;43009.35485967705;43126.353104703376;43148.568514314844;9811.362261453001;10006.049425304584;10017.449040302781;10019.148372388356;10020.74948126299;8863.423877447978;9012.8648070279;12017.819732703972;12203.02375809933;12232.816507752346;12198.512059517609;12252.81620775689;12272.631821045383;12292.201006934565;12428.813567796446;8920.776980575472;12288.447019884126;12398.442070106867;12418.316992565406;12442.315672638002;8649.524276164808;8896.822063558757;8898.777530561723;8902.821943561092;11770.352630605314;38873;41183.97040074022;41205;41213;41233.587664123275;3181.538676891838;3277.885274015398;3434.793912365266;3526.400511912955;3705.925881482355;29031.98388056408;29880.954166604282;29881.402371952438;30369.392612147632;31099.844500777577;3203.775735698502;3244.6917542833394;3259.1363288728508;3379.3579219948133;3392.0671815250757;451456.99999999674;454255;457053;457261;457672.4232757663;58947;59212.703936480044;59386.40613593809;59418.40581594129;59447.10829337563;59337;61507.38492615106;61526;61542;61747;16379;17061.7440738389;17065.40271090506;17071.658566828595;17080.316787328367;11912;12130.150889437655;13232.603021909357;13274.203547787163;13288.202707837561;15502.224888755518;15852.682946341009;15961.760573591406;16118.03291802472;16347.34610615562;5748.540116790647;6882.449404047664;6889.862202755917;6905.620190889549;6951.617661028692;764.186141759036;806.9031716194095;902.7833320003283;1017.8269694152012;1023.1712313026472;29970.904440666513;30017;30155.849220753757;30200.84899575488;30436.956304369385;935.9672411465566;1002.5588740953957;1024.5287167902848;1065.621704294964;1135.5457816873152;15453.459128930434;15454.845451545565;15520.767188492182;15768.68462630741;15874.285657145456;491836;674584;677563;678193;680348;56695.716521417125;56877.431225687214;56892.71553642288;57037.003704870964;57137.85724285491;1197.5209916033482;1215.1918973882268;1215.5806246845177;1326.191023475679;1351.1825345665927;28987.5651865218;30907;31331;32056.35887282288;32522.34706616729;45520.54479455163;53105.46894531005;53449;53847.461525385814;54013.459865400844;530603;627048;627157;628677;632125;28043.43913121767;34661.82669086739;39418.802905985285;39595;39771.00572485595;42533;42724;44602.55397445984;45479.54520454886;46067.76966115282;38106.809465952494;38469.03827404337;38897.80551097226;39969.60030399775;40407.3938890911;32300.35399291954;34165.829170853984;38335.80832095822;39416;39857;36630.63369366379;36961;37284.25431491301;38475.615243847205;38583.614163858;32991.67008329886;34050.29748512614;34199.31601368009;34808;34895.476567850994;25618.487630246917;25777.226683199533;25825.870870645525;25949.834283704196;26021.479570408865 16:34:15 INFO - PROCESS | 2304 | |2;jquery.html;346.80232267607465;371.91631882826385;376.64783427495286;382.50656652917735;399.13786221760984;19871.25385164729;20624.968751562436;21102.577948441023;21931.01310441032;22090.11639534421;20393.286234981777;20566.69149962752;21162.25932092373;21234.920936464205;21474.355769326907;5225.634205605609;5939.67331796751;5948.940510594904;6116.938830611682;6123.234595675541;4200.201961627281;4451.955480445186;6055.788047418341;6162.95229810931;6166.537509686769;4372.8032238549185;4391.516933137353;4393.0994146199955;6741.561798483083;6796.558223715443;5781.161731548902;6768;6794.76218332356;6797.966010169967;6810.114685090956;5861.765529378819;5968.074948383008;5970.820875373745;5981.7308221129715;5984;13114.278714670689;16791.83208167915;18965.24139034437;25321.746782532307;25650.87174564134;1783.3847322673657;2146.62434074038;2161.070739581979;2319.5360927814336;2376.5484557933937;10280.12618927392;11070.557177712883;12976.740465190738;13783.96620253485;16174.35302587895;1853.8702290839647;1854.3973208707225;1860.1815201311379;1893.6686079935955;1904.628597423503;126287;129979;133100;134685.3265733665;137228.70954266086;10115.44365059914;11608.941955290338;11676.299422034705;11702.76594468106;11878.584249551397;14709.632259193391;14734.263286835616;14741;14749.77875331871;14758.92620536912;7139.857202855914;8454.32365410778;8605.698800542075;8658.567071646392;8739.475631462132;8487.533185674847;8488.787780305418;8533.53065581399;8672.392932494664;8711.869321960176;4478.373027776114;4499.887502812456;4509.1658043262105;4527.796249168795;4572.177008138567;1716.3392094043884;1813.3471950097953;1853.342063567441;1898.1932678611536;1906.1517624656894;696.6690821859576;774.2219069834892;836.7447928381902;854.2994744309607;872.583834288765;19940.50148746293;20653.380398588066;21598.56802863934;21704.023318950683;21718.891405542872;905.7826121730869;907.5326207003399;934.2899396458605;980.3480685344166;1045.1482042135788;10857.67426977192;11175.21773475849;11366.545338186379;11426.542938282542;11478.311301321948;630944;637875;640590;649474;652625;116066;117920.8207917927;123538;126177;149203;981.474910922653;1001.0290018681867;1001.2490632025834;1002.2983911262146;1008.8133695266399;18691.90654046721;18906.905465473134;19438.028098595296;19442.8055719441;19493.70759438581;54770.17844732412;56433.43566564282;57709;59320.70339648447;59699.20902372936;85437;86555;88103.55948220218;88396;89214.21571568403;7746.961265193863;8054.677812887653;8204.917950820416;8294.170582941657;8398;9089.181973622406;12514.499420023098;13207.933960330136;13278.668033299246;13980.650483737987;5532.004239236815;7411.7035318588805;11510.223257348442;11891.76216475683;11927.045836333245;10633.255672102878;11445.084393248686;11505.769884602429;11737.823932640846;12085.516579336729;11477.311361318347;11581.247218930743;12040.157188996685;12056.095792815398;12168.513259469877;7163.928360716326;7393.741219057522;7477.878318252306;8032.236937490929;8449.493030418194;8302.169783021649;10185.592576296865;11538.82691759641;11704.648860534198;11935.880641193477 16:34:15 INFO - PROCESS | 2304 | |3;mootools.html;1508.2911031815047;1520.5286361228018;1686.84818366347;1823.4803081121865;1855.2671694680594;8452.154784521545;9023.18791308782;9026.954865225682;9040.68357607483;9043.140901614353;7867.291943725064;8049.637766300516;8077.19228077192;8466.407351485399;8838.381313308071;2360.9527809443844;2411.8311718179734;2415.9637605435933;2417.7944874685586;2421.9515609687796;2383.5709572276983;2387.6060450025725;2392.7248366437907;2423.4789520253144;2423.6970378702663;2073.1707317073215;2396.7483414241515;2411.7105947286263;2419.661247425362;2422.551827911842;2000.3898810862681;2364.9881750591308;2389.092144984912;2389.175734371639;2399.8440101393353;2385.4155731845635;2393.712754469475;2394.856308621488;2396.724376696667;2398.59223931932;8901.73294801157;8920.330975176888;9007.144321289466;9019.188273055457;9029.729108126767;5367.114426119686;5519.420460851633;5530.225768392428;5537.197106419547;5546.223528705985;3479.1302174456387;3556.2176321209295;3683.1344634010984;3684.797336146511;3690.5940346561856;1047.6699839550517;1072.3351522056298;1080.1412876762993;1100.5047728522118;1101.3061771084247;12003.819942700778;12205.20666156706;12210.877891221064;12211.877881221162;12254.877451225462;4749.976250118727;4796.7881593336015;4822.614190864722;4896.877578060506;4926.236433352836;10285.537150828231;10286.228532860065;10289.22830787694;10292.742681432874;10303.330283531546;5503.394626591072;5507.394186639466;5510.834674959758;5519.31008623922;5526.723663816873;4511.751853648081;4626.398568186114;4933.555979961749;5030;5031.119554078022;4002.219567184371;4002.5797291284;4027.35562310029;4116.320807066861;4121.814518346681;1281.9167803206276;1283.0120806978575;1293.8770816772392;1298.214580178997;1309.3453273363318;744.1702501710554;805.7341077444429;815.8205194857122;852.6205838401852;889.9777505562413;5709.68596727184;5753.453421924911;6008.729607167688;6096.878062438726;6218.129461875341;922.9077092290718;948.5162567090833;955.350361754;960.8798900137483;982.8378317577663;3893.201893611803;3995.1610161866333;4009.358502639622;4029.2545879012478;4110.403991421227;10682.51928663212;11192.10463162945;11212.775744485065;11220.831687524693;11232.663020109247;11111.388873611868;11129.165312601588;11132.38771867555;11135.164862635334;11140.721481962853;8022.197780222048;8287.673972164424;8404.537750423786;8405.495670259805;8523.872141917876;5992.280926288873;6017.765980185948;6024.457798798129;6072;6234.657093859882;10194.827594826393;10244.948775256076;10495.790084198426;10509.159267258754;10522.789544209227;10095.7476063099;10421.68734937953;10470.424126673106;10611.734706632087;10633.415162165846;6881.8967715485305;7041.119860017498;7044.6125463100025;7729.961350193213;7881;8270.627821748156;8552.401331906707;8558.400911936355;8675.739727808175;8685.869711954452;7589.6584653689615;7704.383649308154;7704.730334438268;7846.686132554634;7859.17478664732;7457.366123879531;7515.060617422822;7532.43506736986;7534.434917381109;7561;6982.231954484901;7087.574745515286;7099.751508697171;7129.893051604126;7133.3936615388275;4936.864521160225;5006.07387633289;5045.571126454292;5098.974505127599;5255;5042.495750424928;5065.493450654905;5073.746312684425;5120.283160357628;5263.157894736823 16:34:15 INFO - PROCESS | 2304 | |4;prototype.html;254.26644131680104;266.91897813853893;300.87363307410885;304.95883055787476;318.37598307317654;4570.497245303014;5076.79692812288;5311.362636483627;5340.839774806752;5378.946210537893;4258.40382346471;5006.924896126552;5194.480551944804;5238.397584277809;5259.395169555502;3386.3904497190497;4012.294774720747;4022.034711669208;4064.4512990746316;4110.383442483629;3320.7841490303053;3434.055634700452;3762.341590221714;3873.4577159197593;4045.858394956177;3358.4122778513783;3946.5264168299846;3969.364901615742;4039.1921615676983;4063.5936406359274;3375.8480868360984;3377.3751855906735;3626.764260323084;4021.954291884102;4070.69469789764;3008.022392722374;3513.2095278562374;3519.296140771856;3520.4861909378956;3526.6825985661158;3926.7225009494423;4283.507396649394;4547.976705241294;4929.162042452792;4987.551120399182;4268.722533035343;4496.953885981903;4566.817327306904;4566.88582785433;4660;4854.223324268136;5577.24316840194;5583.994880921433;5597.104463285855;5612.831615051514;3693.559511790404;3842.9231415371814;3845.8464059471244;3859.9771060668945;3868.2843673920415;5520.23988005997;5779.479846813807;5841.591088623798;5845.849446892711;5873.500752436048;3415.334009868052;3439.793612383265;3876;3881.4565960765517;3906.648401643866;3513.5783705954937;3966.424868394067;3966.643002129822;3971.2653159165648;3991.44119823225;3838.673712734449;4357.760323182192;4372.562743725665;4514.525974772601;4518.909621807546;4767.380240568773;5484.725763711798;5584.609077364546;5595.244641973363;5661.829375549705;1185.466540056978;1257.874202588678;1289.935503224835;1292.9418176182094;1310.974544329014;858.6737039924789;887.8313120507083;899.347972719786;903.2593273515786;906.0984320601044;3907.023244188953;4768.47546769855;4905;4911.975440122848;4984.501549844987;4365.563443655609;5067.467915868854;5434.592405569598;5661.320641523043;5730.226419433407;4011.8997025074605;4423.889402764957;5187.2478490619405;5210.244514545369;5211.947880521222;2980.2847316643847;3013.433014832275;3017.2909366298904;3019.9547006794915;3021.018169095053;4919.852404427873;5595.692236926927;5954.255718035246;5983.175131584821;5996.4603185713495;4812.425352436429;5311.681299121988;5840.445157710011;5883.735231914488;5900.350961394243;5134.717590532557;5905.822825315161;5993.160957465958;6060.42425969541;6071.362506936796;4579.404677391918;4658.627309815274;5119.74401279927;5575.0522411191005;5713.314402271588;4699.694519856198;5066.468020857904;5448.972755136199;5669.659820410789;5695.145728140812;5699.658020518782;5812.512492504464;5999.3100793407575;6000;6029.87940241184;3702.6297370263837;3780.716446266486;3783.6405541473514;3811.522510368283;3833.8083095845654;5530.866172434722;5554.194641776839;5641.37944826077;5717;5739.651181972316;4650.837220697259;5169.767360468863;5411.863508663225;5555.694436806015;5581.014157425758;4780.760961951958;5407.891842163213;5464;5474.781008759605;5532.806351777668;5175.626595526774;5186.688798672092;5310.964361949383;5405.972865155608;5451.890962180813;4610.423697037871;5486.149646804752;5518.586106041983;5526.889462210653;5540.695261760642;5085.949140508696;5375.596830237826;5381.461853814744;5381.596380271417;5429.945700542944 16:34:15 INFO - PROCESS | 2304 | |5;yui.html;680.5712401187249;710.4174576846985;750.1972889008763;767.8579462799386;822.3667775812622;14873.47942822;15375.308111134998;15930.442434514795;16028.51914442567;16479.752803707925;14383.92808035961;14797.92601036996;14804.40782368704;14811.629709257248;14817.703645927075;685.6845850908588;702.7751119641716;705.1714235772972;836.481381543444;846.7586737779734;833.3749687734199;851.5274022917279;853.2491407561338;855.4140413816524;862.3144600042949;892.2861710631502;893.3835653399166;894.0790985285166;896.6503063805121;897.1387468030698;709.8260926073093;731.7146312937958;890.1054440287502;891.8439273127177;893.1247377569986;640.2253273539023;649.0394216559471;651.7034749189107;654.3848782144769;657.6645910585588;14989.925050374679;14995.95028348016;15002.549923502313;15021.399144034225;15027.474038408713;13668.248246346448;13766.93116534421;13784.379702913293;13961.581152565439;13998.160110393408;10245.385276883337;11379.632575155101;11666.300021998708;12110.515579376814;12336.321502317369;4490.259107247301;4498.482674492442;4584.839530616446;4624.953750462486;4634.443866735979;121555;124719;126124;130067;130399;10707.732306692395;10856.674299771019;10971.23201375896;11018.063464605599;11134.665960021212;21268.468288292916;21301.14795408166;21331.68002479964;21374.893125534585;21689.891550542146;7795.454318197785;7832.451728379073;7884.250996155471;7889.053313602404;7945.6027198640995;4313.266744653416;4319.07139964909;4321.330193819963;4561.817527298871;4575;3534.3638145134123;3679.7608155469807;3680.024793429743;3686.944695829565;3689.612590677994;658.2594581096266;658.7760161545098;660.923993740726;666.5167753378762;667.259342130235;526.4235661950158;546.1561886884773;581.8312689320135;583.614814222611;647.2200997797643;8220.383471239562;8888.511131887679;8910.287177025823;9029.051949545334;9128.726138215865;569.8005698005664;590.3594599859115;607.3501353551658;607.471499795181;623.6351734235523;4241.066965267636;4318.827246910151;4333.609975102256;4375.5405682403525;4510.300903359985;160427;161005.19497402437;162024;163762;164614.17692911698;138423.11595789282;141281.5871841289;141692;143020;143258;117516.64966700618;122827;123862.14206786905;125207;125584;8140.633671484916;8302.54336011501;8442.873356899529;8602.923556194673;8676.566171691517;65291.673541633885;66175;66519.66740166461;66697;69247;70096;79060;94758;97926;100149.99850001407;12963.962882969152;13102.868971310165;13328.33358332099;13337.599872003855;13559.728805424034;14323.57029289123;14719.55841324762;14926.925365373103;14941.551753447415;15279.923600381928;13462.46150154022;13716;14106.717865642424;14128.576142715736;14163.787543186654;13731.794023089462;13810.516631917835;13859.584212473643;14057;14089.647758806112;13474.326283685972;13737.24445155526;13764.65588360299;13920.791188132389;14001.719965600834;10173.694789156338;11130.158381104246;11233.38216398106;11574.363410012193;11942.462589183333;11501.654950351503;11645.308675011753;11662.766744665229;11693.473793679135;11729.47217375203 16:34:15 INFO - PROCESS | 2304 | __end_tp_report 16:34:15 INFO - PROCESS | 2304 | __start_cc_report 16:34:15 INFO - PROCESS | 2304 | _x_x_mozilla_cycle_collect,1191 16:34:15 INFO - PROCESS | 2304 | __end_cc_report 16:34:15 INFO - PROCESS | 2304 | __startTimestamp1476142455102__endTimestamp 16:34:15 INFO - PROCESS | 2304 | 16:34:15 INFO - PROCESS | 2304 | ------- Summary: start ------- 16:34:15 INFO - PROCESS | 2304 | Number of tests: 6 16:34:15 INFO - PROCESS | 2304 | 16:34:15 INFO - PROCESS | 2304 | [#0] dojo.html Cycles:165 Average:5679.35 Median:5793.57 stddev:650.73 (11.2%) stddev-sans-first:625.23 16:34:15 INFO - PROCESS | 2304 | Values: 3293.7 3295.2 3337.5 3342.1 3376.8 5717.5 5777.5 5779.3 5780.9 5793.6 5649.3 5738.4 5751.3 5752.8 5763.0 4342.3 5182.3 5217.5 5225.0 5236.8 5164.6 5176.1 5190.0 5305.5 5345.2 5201.1 5210.9 5234.0 5249.3 5260.3 5224.3 5250.9 5286.0 5287.9 5313.7 4622.1 5060.9 5126.7 5228.1 5256.4 5530.8 5544.5 5546.4 5600.7 5648.4 5435.5 6238.9 6272.1 6277.9 6302.7 6275.6 6277.7 6324.3 6342.2 6342.8 5626.6 5669.8 5689.7 5734.5 5795.8 6327.8 6336.6 6356.3 6364.0 6375.6 6034.0 6163.9 6164.2 6175.9 6191.3 6104.7 6127.2 6156.8 6305.2 6320.8 6118.4 6218.9 6221.5 6237.0 6256.1 6224.0 6224.9 6236.5 6240.9 6248.8 4793.6 4858.5 4865.5 4911.6 4913.5 4369.9 4440.7 4441.0 4452.8 4457.4 5383.5 5392.6 5397.9 5399.1 5403.8 6152.8 6238.0 6242.4 6249.9 6259.1 5393.9 5445.0 5459.9 5464.2 5491.5 5169.4 5201.8 5318.3 5342.0 5365.9 6240.9 6303.2 6319.0 6330.6 6330.7 6245.5 6267.6 6270.7 6271.4 6285.1 6286.7 6303.6 6313.6 6316.1 6329.2 5908.1 5931.3 5962.0 6009.6 6063.0 6193.9 6193.9 6200.2 6212.7 6223.0 5274.3 5823.5 5919.4 5968.1 6017.9 5765.6 5819.4 5872.4 5951.2 5958.2 5708.8 5766.8 5769.6 5794.8 5873.1 5941.6 5946.0 5948.8 5953.7 5960.4 5752.7 5760.4 5783.4 5801.3 5818.5 16:34:15 INFO - PROCESS | 2304 | 16:34:15 INFO - PROCESS | 2304 | [#1] ext.html Cycles:180 Average:70425.17 Median:37695.53 stddev:154036.16 (408.6%) stddev-sans-first:154378.74 16:34:15 INFO - PROCESS | 2304 | Values: 475.1 477.2 480.6 507.0 520.7 29849.9 39510.0 40859.0 41011.2 43473.6 42595.6 42999.4 43009.4 43126.4 43148.6 9811.4 10006.0 10017.4 10019.1 10020.7 8863.4 9012.9 12017.8 12203.0 12232.8 12198.5 12252.8 12272.6 12292.2 12428.8 8920.8 12288.4 12398.4 12418.3 12442.3 8649.5 8896.8 8898.8 8902.8 11770.4 38873.0 41184.0 41205.0 41213.0 41233.6 3181.5 3277.9 3434.8 3526.4 3705.9 29032.0 29881.0 29881.4 30369.4 31099.8 3203.8 3244.7 3259.1 3379.4 3392.1 451457.0 454255.0 457053.0 457261.0 457672.4 58947.0 59212.7 59386.4 59418.4 59447.1 59337.0 61507.4 61526.0 61542.0 61747.0 16379.0 17061.7 17065.4 17071.7 17080.3 11912.0 12130.2 13232.6 13274.2 13288.2 15502.2 15852.7 15961.8 16118.0 16347.3 5748.5 6882.4 6889.9 6905.6 6951.6 764.2 806.9 902.8 1017.8 1023.2 29970.9 30017.0 30155.8 30200.8 30437.0 936.0 1002.6 1024.5 1065.6 1135.5 15453.5 15454.8 15520.8 15768.7 15874.3 491836.0 674584.0 677563.0 678193.0 680348.0 56695.7 56877.4 56892.7 57037.0 57137.9 1197.5 1215.2 1215.6 1326.2 1351.2 28987.6 30907.0 31331.0 32056.4 32522.3 45520.5 53105.5 53449.0 53847.5 54013.5 530603.0 627048.0 627157.0 628677.0 632125.0 28043.4 34661.8 39418.8 39595.0 39771.0 42533.0 42724.0 44602.6 45479.5 46067.8 38106.8 38469.0 38897.8 39969.6 40407.4 32300.4 34165.8 38335.8 39416.0 39857.0 36630.6 36961.0 37284.3 38475.6 38583.6 32991.7 34050.3 34199.3 34808.0 34895.5 25618.5 25777.2 25825.9 25949.8 26021.5 16:34:15 INFO - PROCESS | 2304 | 16:34:15 INFO - PROCESS | 2304 | [#2] jquery.html Cycles:180 Average:36957.47 Median:22010.56 stddev:107275.90 (487.4%) stddev-sans-first:107541.62 16:34:15 INFO - PROCESS | 2304 | Values: 346.8 371.9 376.6 382.5 399.1 19871.3 20625.0 21102.6 21931.0 22090.1 20393.3 20566.7 21162.3 21234.9 21474.4 5225.6 5939.7 5948.9 6116.9 6123.2 4200.2 4452.0 6055.8 6163.0 6166.5 4372.8 4391.5 4393.1 6741.6 6796.6 5781.2 6768.0 6794.8 6798.0 6810.1 5861.8 5968.1 5970.8 5981.7 5984.0 13114.3 16791.8 18965.2 25321.7 25650.9 1783.4 2146.6 2161.1 2319.5 2376.5 10280.1 11070.6 12976.7 13784.0 16174.4 1853.9 1854.4 1860.2 1893.7 1904.6 126287.0 129979.0 133100.0 134685.3 137228.7 10115.4 11608.9 11676.3 11702.8 11878.6 14709.6 14734.3 14741.0 14749.8 14758.9 7139.9 8454.3 8605.7 8658.6 8739.5 8487.5 8488.8 8533.5 8672.4 8711.9 4478.4 4499.9 4509.2 4527.8 4572.2 1716.3 1813.3 1853.3 1898.2 1906.2 696.7 774.2 836.7 854.3 872.6 19940.5 20653.4 21598.6 21704.0 21718.9 905.8 907.5 934.3 980.3 1045.1 10857.7 11175.2 11366.5 11426.5 11478.3 630944.0 637875.0 640590.0 649474.0 652625.0 116066.0 117920.8 123538.0 126177.0 149203.0 981.5 1001.0 1001.2 1002.3 1008.8 18691.9 18906.9 19438.0 19442.8 19493.7 54770.2 56433.4 57709.0 59320.7 59699.2 85437.0 86555.0 88103.6 88396.0 89214.2 7747.0 8054.7 8204.9 8294.2 8398.0 9089.2 12514.5 13207.9 13278.7 13980.7 5532.0 7411.7 11510.2 11891.8 11927.0 10633.3 11445.1 11505.8 11737.8 12085.5 11477.3 11581.2 12040.2 12056.1 12168.5 7163.9 7393.7 7477.9 8032.2 8449.5 8302.2 10185.6 11538.8 11704.6 11935.9 16:34:15 INFO - PROCESS | 2304 | 16:34:15 INFO - PROCESS | 2304 | [#3] mootools.html Cycles:180 Average:5846.94 Median:4911.56 stddev:3309.21 (67.4%) stddev-sans-first:3302.43 16:34:15 INFO - PROCESS | 2304 | Values: 1508.3 1520.5 1686.8 1823.5 1855.3 8452.2 9023.2 9027.0 9040.7 9043.1 7867.3 8049.6 8077.2 8466.4 8838.4 2361.0 2411.8 2416.0 2417.8 2422.0 2383.6 2387.6 2392.7 2423.5 2423.7 2073.2 2396.7 2411.7 2419.7 2422.6 2000.4 2365.0 2389.1 2389.2 2399.8 2385.4 2393.7 2394.9 2396.7 2398.6 8901.7 8920.3 9007.1 9019.2 9029.7 5367.1 5519.4 5530.2 5537.2 5546.2 3479.1 3556.2 3683.1 3684.8 3690.6 1047.7 1072.3 1080.1 1100.5 1101.3 12003.8 12205.2 12210.9 12211.9 12254.9 4750.0 4796.8 4822.6 4896.9 4926.2 10285.5 10286.2 10289.2 10292.7 10303.3 5503.4 5507.4 5510.8 5519.3 5526.7 4511.8 4626.4 4933.6 5030.0 5031.1 4002.2 4002.6 4027.4 4116.3 4121.8 1281.9 1283.0 1293.9 1298.2 1309.3 744.2 805.7 815.8 852.6 890.0 5709.7 5753.5 6008.7 6096.9 6218.1 922.9 948.5 955.4 960.9 982.8 3893.2 3995.2 4009.4 4029.3 4110.4 10682.5 11192.1 11212.8 11220.8 11232.7 11111.4 11129.2 11132.4 11135.2 11140.7 8022.2 8287.7 8404.5 8405.5 8523.9 5992.3 6017.8 6024.5 6072.0 6234.7 10194.8 10244.9 10495.8 10509.2 10522.8 10095.7 10421.7 10470.4 10611.7 10633.4 6881.9 7041.1 7044.6 7730.0 7881.0 8270.6 8552.4 8558.4 8675.7 8685.9 7589.7 7704.4 7704.7 7846.7 7859.2 7457.4 7515.1 7532.4 7534.4 7561.0 6982.2 7087.6 7099.8 7129.9 7133.4 4936.9 5006.1 5045.6 5099.0 5255.0 5042.5 5065.5 5073.7 5120.3 5263.2 16:34:15 INFO - PROCESS | 2304 | 16:34:15 INFO - PROCESS | 2304 | [#4] prototype.html Cycles:180 Average:4438.09 Median:4915.91 stddev:1380.11 (28.1%) stddev-sans-first:1347.78 16:34:15 INFO - PROCESS | 2304 | Values: 254.3 266.9 300.9 305.0 318.4 4570.5 5076.8 5311.4 5340.8 5378.9 4258.4 5006.9 5194.5 5238.4 5259.4 3386.4 4012.3 4022.0 4064.5 4110.4 3320.8 3434.1 3762.3 3873.5 4045.9 3358.4 3946.5 3969.4 4039.2 4063.6 3375.8 3377.4 3626.8 4022.0 4070.7 3008.0 3513.2 3519.3 3520.5 3526.7 3926.7 4283.5 4548.0 4929.2 4987.6 4268.7 4497.0 4566.8 4566.9 4660.0 4854.2 5577.2 5584.0 5597.1 5612.8 3693.6 3842.9 3845.8 3860.0 3868.3 5520.2 5779.5 5841.6 5845.8 5873.5 3415.3 3439.8 3876.0 3881.5 3906.6 3513.6 3966.4 3966.6 3971.3 3991.4 3838.7 4357.8 4372.6 4514.5 4518.9 4767.4 5484.7 5584.6 5595.2 5661.8 1185.5 1257.9 1289.9 1292.9 1311.0 858.7 887.8 899.3 903.3 906.1 3907.0 4768.5 4905.0 4912.0 4984.5 4365.6 5067.5 5434.6 5661.3 5730.2 4011.9 4423.9 5187.2 5210.2 5211.9 2980.3 3013.4 3017.3 3020.0 3021.0 4919.9 5595.7 5954.3 5983.2 5996.5 4812.4 5311.7 5840.4 5883.7 5900.4 5134.7 5905.8 5993.2 6060.4 6071.4 4579.4 4658.6 5119.7 5575.1 5713.3 4699.7 5066.5 5449.0 5669.7 5695.1 5699.7 5812.5 5999.3 6000.0 6029.9 3702.6 3780.7 3783.6 3811.5 3833.8 5530.9 5554.2 5641.4 5717.0 5739.7 4650.8 5169.8 5411.9 5555.7 5581.0 4780.8 5407.9 5464.0 5474.8 5532.8 5175.6 5186.7 5311.0 5406.0 5451.9 4610.4 5486.1 5518.6 5526.9 5540.7 5085.9 5375.6 5381.5 5381.6 5429.9 16:34:15 INFO - PROCESS | 2304 | 16:34:15 INFO - PROCESS | 2304 | [#5] yui.html Cycles:180 Average:26474.79 Median:12612.13 stddev:43540.22 (345.2%) stddev-sans-first:43619.29 16:34:15 INFO - PROCESS | 2304 | Values: 680.6 710.4 750.2 767.9 822.4 14873.5 15375.3 15930.4 16028.5 16479.8 14383.9 14797.9 14804.4 14811.6 14817.7 685.7 702.8 705.2 836.5 846.8 833.4 851.5 853.2 855.4 862.3 892.3 893.4 894.1 896.7 897.1 709.8 731.7 890.1 891.8 893.1 640.2 649.0 651.7 654.4 657.7 14989.9 14996.0 15002.5 15021.4 15027.5 13668.2 13766.9 13784.4 13961.6 13998.2 10245.4 11379.6 11666.3 12110.5 12336.3 4490.3 4498.5 4584.8 4625.0 4634.4 121555.0 124719.0 126124.0 130067.0 130399.0 10707.7 10856.7 10971.2 11018.1 11134.7 21268.5 21301.1 21331.7 21374.9 21689.9 7795.5 7832.5 7884.3 7889.1 7945.6 4313.3 4319.1 4321.3 4561.8 4575.0 3534.4 3679.8 3680.0 3686.9 3689.6 658.3 658.8 660.9 666.5 667.3 526.4 546.2 581.8 583.6 647.2 8220.4 8888.5 8910.3 9029.1 9128.7 569.8 590.4 607.4 607.5 623.6 4241.1 4318.8 4333.6 4375.5 4510.3 160427.0 161005.2 162024.0 163762.0 164614.2 138423.1 141281.6 141692.0 143020.0 143258.0 117516.6 122827.0 123862.1 125207.0 125584.0 8140.6 8302.5 8442.9 8602.9 8676.6 65291.7 66175.0 66519.7 66697.0 69247.0 70096.0 79060.0 94758.0 97926.0 100150.0 12964.0 13102.9 13328.3 13337.6 13559.7 14323.6 14719.6 14926.9 14941.6 15279.9 13462.5 13716.0 14106.7 14128.6 14163.8 13731.8 13810.5 13859.6 14057.0 14089.6 13474.3 13737.2 13764.7 13920.8 14001.7 10173.7 11130.2 11233.4 11574.4 11942.5 11501.7 11645.3 11662.8 11693.5 11729.5 16:34:15 INFO - PROCESS | 2304 | -------- Summary: end -------- 16:34:15 INFO - PROCESS | 2304 | 16:34:15 INFO - TEST-INFO | 2304: exit 0 16:34:15 INFO - TEST-OK | dromaeo_css | took 1116153ms 16:34:15 INFO - TEST-START | kraken 16:34:15 INFO - operating with platform_type : mac_ 16:34:15 INFO - Initialising browser for kraken test... 16:34:15 INFO - TEST-INFO | started process 2307 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpmGCHPY/profile http://localhost:53005/getInfo.html) 16:34:17 INFO - PROCESS | 2307 | __metrics Screen width/height:1600/1200 16:34:17 INFO - PROCESS | 2307 | colorDepth:24 16:34:17 INFO - PROCESS | 2307 | Browser inner width/height: 1024/689 16:34:17 INFO - PROCESS | 2307 | __metrics 16:34:17 INFO - PROCESS | 2307 | 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" 16:34:17 INFO - PROCESS | 2307 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:34:18 INFO - TEST-INFO | 2307: exit 0 16:34:18 INFO - Browser initialized. 16:34:18 INFO - Running cycle 1/1 for kraken test... 16:34:18 INFO - TEST-INFO | started process 2308 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpmGCHPY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:34:30 INFO - PROCESS | 2308 | RSS: Main: 219201536 16:34:30 INFO - PROCESS | 2308 | 16:34:33 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:53005/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53005/tests/kraken/driver.html?testName=audio-beat-detection) 16:34:34 INFO - PROCESS | 2308 | RSS: Main: 270290944 16:34:34 INFO - PROCESS | 2308 | 16:34:36 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:53005/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53005/tests/kraken/driver.html?testName=audio-dft) 16:34:37 INFO - PROCESS | 2308 | RSS: Main: 281559040 16:34:37 INFO - PROCESS | 2308 | 16:34:40 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:53005/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53005/tests/kraken/driver.html?testName=audio-fft) 16:34:41 INFO - PROCESS | 2308 | RSS: Main: 376758272 16:34:41 INFO - PROCESS | 2308 | 16:34:43 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:53005/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53005/tests/kraken/driver.html?testName=audio-oscillator) 16:34:43 INFO - PROCESS | 2308 | RSS: Main: 278740992 16:34:43 INFO - PROCESS | 2308 | 16:34:45 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:53005/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53005/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:34:46 INFO - PROCESS | 2308 | RSS: Main: 281059328 16:34:46 INFO - PROCESS | 2308 | 16:34:49 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:53005/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53005/tests/kraken/driver.html?testName=imaging-darkroom) 16:34:49 INFO - PROCESS | 2308 | RSS: Main: 316850176 16:34:49 INFO - PROCESS | 2308 | 16:34:52 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:53005/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53005/tests/kraken/driver.html?testName=imaging-desaturate) 16:34:53 INFO - PROCESS | 2308 | RSS: Main: 318865408 16:34:53 INFO - PROCESS | 2308 | 16:34:55 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:53005/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53005/tests/kraken/driver.html?testName=json-parse-financial) 16:34:56 INFO - PROCESS | 2308 | RSS: Main: 317239296 16:34:56 INFO - PROCESS | 2308 | 16:34:58 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:53005/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53005/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:34:58 INFO - PROCESS | 2308 | RSS: Main: 289792000 16:34:58 INFO - PROCESS | 2308 | 16:35:00 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:53005/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53005/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:35:01 INFO - PROCESS | 2308 | RSS: Main: 294133760 16:35:01 INFO - PROCESS | 2308 | 16:35:03 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:53005/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53005/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:35:04 INFO - PROCESS | 2308 | RSS: Main: 302858240 16:35:04 INFO - PROCESS | 2308 | 16:35:06 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:53005/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53005/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:35:07 INFO - PROCESS | 2308 | RSS: Main: 308879360 16:35:07 INFO - PROCESS | 2308 | 16:35:10 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:53005/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53005/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:35:11 INFO - PROCESS | 2308 | RSS: Main: 308813824 16:35:11 INFO - PROCESS | 2308 | 16:35:12 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:53005/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53005/tests/kraken/driver.html?testName=ai-astar) 16:35:13 INFO - PROCESS | 2308 | RSS: Main: 352849920 16:35:13 INFO - PROCESS | 2308 | 16:35:13 INFO - PROCESS | 2308 | __start_tp_report 16:35:13 INFO - PROCESS | 2308 | _x_x_mozilla_page_load 16:35:13 INFO - PROCESS | 2308 | _x_x_mozilla_page_load_details 16:35:13 INFO - PROCESS | 2308 | |i|pagename|runs| 16:35:13 INFO - PROCESS | 2308 | |0;ai-astar;113;113;112;117;113;113;113;113;113;114 16:35:13 INFO - PROCESS | 2308 | |1;audio-beat-detection;144;110;109;140;110;110;120;109;140;108 16:35:13 INFO - PROCESS | 2308 | |2;audio-dft;183;183;182;184;183;180;186;184;183;183 16:35:13 INFO - PROCESS | 2308 | |3;audio-fft;82;58;61;90;63;59;59;59;83;56 16:35:13 INFO - PROCESS | 2308 | |4;audio-oscillator;89;70;95;69;68;68;91;67;69;90 16:35:13 INFO - PROCESS | 2308 | |5;imaging-gaussian-blur;88;85;87;85;85;87;135;84;88;83 16:35:13 INFO - PROCESS | 2308 | |6;imaging-darkroom;93;92;93;93;92;92;93;92;94;100 16:35:13 INFO - PROCESS | 2308 | |7;imaging-desaturate;85;102;141;85;85;87;83;85;84;86 16:35:13 INFO - PROCESS | 2308 | |8;json-parse-financial;58;53;53;53;58;57;58;58;58;58 16:35:13 INFO - PROCESS | 2308 | |9;json-stringify-tinderbox;71;66;73;74;71;69;69;71;70;71 16:35:13 INFO - PROCESS | 2308 | |10;stanford-crypto-aes;82;81;85;82;83;83;85;86;91;90 16:35:13 INFO - PROCESS | 2308 | |11;stanford-crypto-ccm;137;137;155;126;136;134;141;143;169;136 16:35:13 INFO - PROCESS | 2308 | |12;stanford-crypto-pbkdf2;162;165;162;163;162;163;161;163;165;212 16:35:13 INFO - PROCESS | 2308 | |13;stanford-crypto-sha256-iterative;67;66;66;67;65;65;68;66;67;66 16:35:13 INFO - PROCESS | 2308 | __end_tp_report 16:35:13 INFO - PROCESS | 2308 | __start_cc_report 16:35:13 INFO - PROCESS | 2308 | _x_x_mozilla_cycle_collect,1983 16:35:13 INFO - PROCESS | 2308 | __end_cc_report 16:35:13 INFO - PROCESS | 2308 | __startTimestamp1476142513111__endTimestamp 16:35:13 INFO - PROCESS | 2308 | 16:35:13 INFO - PROCESS | 2308 | ------- Summary: start ------- 16:35:13 INFO - PROCESS | 2308 | Number of tests: 14 16:35:13 INFO - PROCESS | 2308 | 16:35:13 INFO - PROCESS | 2308 | [#0] ai-astar Cycles:10 Average:113.40 Median:113.00 stddev:1.35 (1.2%) stddev-sans-first:1.42 16:35:13 INFO - PROCESS | 2308 | Values: 113.0 113.0 112.0 117.0 113.0 113.0 113.0 113.0 113.0 114.0 16:35:13 INFO - PROCESS | 2308 | 16:35:13 INFO - PROCESS | 2308 | [#1] audio-beat-detection Cycles:10 Average:120.00 Median:115.00 stddev:15.14 (13.2%) stddev-sans-first:13.33 16:35:13 INFO - PROCESS | 2308 | Values: 144.0 110.0 109.0 140.0 110.0 110.0 120.0 109.0 140.0 108.0 16:35:13 INFO - PROCESS | 2308 | 16:35:13 INFO - PROCESS | 2308 | [#2] audio-dft Cycles:10 Average:183.10 Median:183.00 stddev:1.52 (0.8%) stddev-sans-first:1.62 16:35:13 INFO - PROCESS | 2308 | Values: 183.0 183.0 182.0 184.0 183.0 180.0 186.0 184.0 183.0 183.0 16:35:13 INFO - PROCESS | 2308 | 16:35:13 INFO - PROCESS | 2308 | [#3] audio-fft Cycles:10 Average:67.00 Median:62.00 stddev:12.72 (20.5%) stddev-sans-first:12.28 16:35:13 INFO - PROCESS | 2308 | Values: 82.0 58.0 61.0 90.0 63.0 59.0 59.0 59.0 83.0 56.0 16:35:13 INFO - PROCESS | 2308 | 16:35:13 INFO - PROCESS | 2308 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:79.50 stddev:11.87 (14.9%) stddev-sans-first:11.85 16:35:13 INFO - PROCESS | 2308 | Values: 89.0 70.0 95.0 69.0 68.0 68.0 91.0 67.0 69.0 90.0 16:35:13 INFO - PROCESS | 2308 | 16:35:13 INFO - PROCESS | 2308 | [#5] imaging-gaussian-blur Cycles:10 Average:90.70 Median:86.00 stddev:15.66 (18.2%) stddev-sans-first:16.58 16:35:13 INFO - PROCESS | 2308 | Values: 88.0 85.0 87.0 85.0 85.0 87.0 135.0 84.0 88.0 83.0 16:35:13 INFO - PROCESS | 2308 | 16:35:13 INFO - PROCESS | 2308 | [#6] imaging-darkroom Cycles:10 Average:93.40 Median:93.00 stddev:2.41 (2.6%) stddev-sans-first:2.55 16:35:13 INFO - PROCESS | 2308 | Values: 93.0 92.0 93.0 93.0 92.0 92.0 93.0 92.0 94.0 100.0 16:35:13 INFO - PROCESS | 2308 | 16:35:13 INFO - PROCESS | 2308 | [#7] imaging-desaturate Cycles:10 Average:92.30 Median:85.00 stddev:17.96 (21.1%) stddev-sans-first:18.85 16:35:13 INFO - PROCESS | 2308 | Values: 85.0 102.0 141.0 85.0 85.0 87.0 83.0 85.0 84.0 86.0 16:35:13 INFO - PROCESS | 2308 | 16:35:13 INFO - PROCESS | 2308 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:58.00 stddev:2.37 (4.1%) stddev-sans-first:2.44 16:35:13 INFO - PROCESS | 2308 | Values: 58.0 53.0 53.0 53.0 58.0 57.0 58.0 58.0 58.0 58.0 16:35:13 INFO - PROCESS | 2308 | 16:35:13 INFO - PROCESS | 2308 | [#9] json-stringify-tinderbox Cycles:10 Average:70.50 Median:71.00 stddev:2.22 (3.1%) stddev-sans-first:2.35 16:35:13 INFO - PROCESS | 2308 | Values: 71.0 66.0 73.0 74.0 71.0 69.0 69.0 71.0 70.0 71.0 16:35:13 INFO - PROCESS | 2308 | 16:35:13 INFO - PROCESS | 2308 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.00 stddev:3.39 (4.0%) stddev-sans-first:3.44 16:35:13 INFO - PROCESS | 2308 | Values: 82.0 81.0 85.0 82.0 83.0 83.0 85.0 86.0 91.0 90.0 16:35:13 INFO - PROCESS | 2308 | 16:35:13 INFO - PROCESS | 2308 | [#11] stanford-crypto-ccm Cycles:10 Average:141.40 Median:139.00 stddev:12.19 (8.8%) stddev-sans-first:12.83 16:35:13 INFO - PROCESS | 2308 | Values: 137.0 137.0 155.0 126.0 136.0 134.0 141.0 143.0 169.0 136.0 16:35:13 INFO - PROCESS | 2308 | 16:35:13 INFO - PROCESS | 2308 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.80 Median:163.00 stddev:15.58 (9.6%) stddev-sans-first:16.39 16:35:13 INFO - PROCESS | 2308 | Values: 162.0 165.0 162.0 163.0 162.0 163.0 161.0 163.0 165.0 212.0 16:35:13 INFO - PROCESS | 2308 | 16:35:13 INFO - PROCESS | 2308 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:0.95 (1.4%) stddev-sans-first:0.97 16:35:13 INFO - PROCESS | 2308 | Values: 67.0 66.0 66.0 67.0 65.0 65.0 68.0 66.0 67.0 66.0 16:35:13 INFO - PROCESS | 2308 | -------- Summary: end -------- 16:35:13 INFO - PROCESS | 2308 | 16:35:13 INFO - TEST-INFO | 2308: exit 0 16:35:13 INFO - TEST-OK | kraken | took 58209ms 16:35:13 INFO - SUITE-END | took 1174s 16:35:14 INFO - Completed test suite (00:19:34) 16:35:14 INFO - javascript benchmark 16:35:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3293.703566678999, 3295.209149804047, 3337.5494308268376, 3342.064222017836, 3376.797392156471, 5717.485426311631, 5777.480026797587, 5779.335376431712, 5780.9132863007035, 5793.565482588807, 5649.322081350233, 5738.42615738426, 5751.281089863767, 5752.7986520471795, 5763.0, 4342.3052311630145, 5182.3262975813095, 5217.47825217479, 5224.981128679909, 5236.7905283788605, 5164.6384753067305, 5176.120059589879, 5190.0, 5305.495977882095, 5345.198220266952, 5201.141811601081, 5210.895782084356, 5233.973830130844, 5249.291345668324, 5260.316158899338, 5224.294720212761, 5250.894982100336, 5286.04851126797, 5287.920681189786, 5313.707746073965, 4622.14490319292, 5060.924086138711, 5126.71803050832, 5228.111221092423, 5256.421793602701, 5530.778768849241, 5544.500994910437, 5546.4453554644615, 5600.663960162363, 5648.435156484319, 5435.537979271727, 6238.9376106238815, 6272.1219029335925, 6277.87444251117, 6302.684865756693, 6275.560710750249, 6277.717502712343, 6324.33594472583, 6342.175517182783, 6342.809715708536, 5626.606137570372, 5669.773209071591, 5689.687067211343, 5734.541236701054, 5795.7971470999155, 6327.810165695037, 6336.58812177207, 6356.269029061717, 6364.045393191059, 6375.553711240262, 6034.034554471264, 6163.9383606164265, 6164.229471316085, 6175.907361389583, 6191.288001879841, 6104.701693046543, 6127.189528148541, 6156.78451254204, 6305.243370795442, 6320.810375688737, 6118.3755344619085, 6218.906716399258, 6221.5333849961435, 6237.0, 6256.124142620037, 6224.0, 6224.875502489925, 6236.532260080512, 6240.937590624127, 6248.781292654735, 4793.592544633745, 4858.46556878743, 4865.489123642037, 4911.557959783565, 4913.459519452857, 4369.890752731144, 4440.689151759346, 4441.0, 4452.844150454718, 4457.398251236042, 5383.461653834585, 5392.649477783932, 5397.946020539823, 5399.136138217867, 5403.756830942617, 6152.846178845564, 6238.0, 6242.375762423812, 6249.875022495994, 6259.0924315973925, 5393.919091213635, 5445.047116754631, 5459.935312614081, 5464.153056276284, 5491.505764481216, 5169.405518365361, 5201.817936372209, 5318.335208098988, 5341.973290133602, 5365.892682146336, 6240.875182496325, 6303.212098487689, 6319.0, 6330.620162790247, 6330.651814150174, 6245.469135123383, 6267.561270711007, 6270.655113968775, 6271.404216599598, 6285.088662143872, 6286.74853005893, 6303.558750887394, 6313.589616674902, 6316.052592111037, 6329.2404911409085, 5908.113782932594, 5931.3178984417345, 5962.0, 6009.639421634716, 6063.029915213545, 6193.876122477435, 6193.907091393543, 6200.162977997912, 6212.658303793335, 6223.0354295084335, 5274.314339135888, 5823.534117270693, 5919.437653422918, 5968.134620479919, 6017.909731353946, 5765.596408251382, 5819.418058194146, 5872.354041055566, 5951.226340575698, 5958.225430693982, 5708.828735137952, 5766.798162064308, 5769.59612827098, 5794.82615521535, 5873.148393483007, 5941.554383421174, 5945.970270148621, 5948.821535353946, 5953.732082056231, 5960.403959604005, 5752.654840709571, 5760.366359700346, 5783.421657834183, 5801.274840644919, 5818.534517238695], "value": 5637.066450991448, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [475.0783480048705, 477.23642172523967, 480.61550759392475, 506.97972081116745, 520.6563667979135, 29849.850750746242, 39510.0, 40858.97852553688, 41011.17977640449, 43473.565264347344, 42595.57404425955, 42999.3550096748, 43009.35485967705, 43126.353104703376, 43148.568514314844, 9811.362261453001, 10006.049425304584, 10017.449040302781, 10019.148372388356, 10020.74948126299, 8863.423877447978, 9012.8648070279, 12017.819732703972, 12203.02375809933, 12232.816507752346, 12198.512059517609, 12252.81620775689, 12272.631821045383, 12292.201006934565, 12428.813567796446, 8920.776980575472, 12288.447019884126, 12398.442070106867, 12418.316992565406, 12442.315672638002, 8649.524276164808, 8896.822063558757, 8898.777530561723, 8902.821943561092, 11770.352630605314, 38873.0, 41183.97040074022, 41205.0, 41213.0, 41233.587664123275, 3181.538676891838, 3277.885274015398, 3434.793912365266, 3526.400511912955, 3705.925881482355, 29031.98388056408, 29880.954166604282, 29881.402371952438, 30369.392612147632, 31099.844500777577, 3203.775735698502, 3244.6917542833394, 3259.1363288728508, 3379.3579219948133, 3392.0671815250757, 451456.99999999674, 454255.0, 457053.0, 457261.0, 457672.4232757663, 58947.0, 59212.703936480044, 59386.40613593809, 59418.40581594129, 59447.10829337563, 59337.0, 61507.38492615106, 61526.0, 61542.0, 61747.0, 16379.0, 17061.7440738389, 17065.40271090506, 17071.658566828595, 17080.316787328367, 11912.0, 12130.150889437655, 13232.603021909357, 13274.203547787163, 13288.202707837561, 15502.224888755518, 15852.682946341009, 15961.760573591406, 16118.03291802472, 16347.34610615562, 5748.540116790647, 6882.449404047664, 6889.862202755917, 6905.620190889549, 6951.617661028692, 764.186141759036, 806.9031716194095, 902.7833320003283, 1017.8269694152012, 1023.1712313026472, 29970.904440666513, 30017.0, 30155.849220753757, 30200.84899575488, 30436.956304369385, 935.9672411465566, 1002.5588740953957, 1024.5287167902848, 1065.621704294964, 1135.5457816873152, 15453.459128930434, 15454.845451545565, 15520.767188492182, 15768.68462630741, 15874.285657145456, 491836.0, 674584.0, 677563.0, 678193.0, 680348.0, 56695.716521417125, 56877.431225687214, 56892.71553642288, 57037.003704870964, 57137.85724285491, 1197.5209916033482, 1215.1918973882268, 1215.5806246845177, 1326.191023475679, 1351.1825345665927, 28987.5651865218, 30907.0, 31331.0, 32056.35887282288, 32522.34706616729, 45520.54479455163, 53105.46894531005, 53449.0, 53847.461525385814, 54013.459865400844, 530603.0, 627048.0, 627157.0, 628677.0, 632125.0, 28043.43913121767, 34661.82669086739, 39418.802905985285, 39595.0, 39771.00572485595, 42533.0, 42724.0, 44602.55397445984, 45479.54520454886, 46067.76966115282, 38106.809465952494, 38469.03827404337, 38897.80551097226, 39969.60030399775, 40407.3938890911, 32300.35399291954, 34165.829170853984, 38335.80832095822, 39416.0, 39857.0, 36630.63369366379, 36961.0, 37284.25431491301, 38475.615243847205, 38583.614163858, 32991.67008329886, 34050.29748512614, 34199.31601368009, 34808.0, 34895.476567850994, 25618.487630246917, 25777.226683199533, 25825.870870645525, 25949.834283704196, 26021.479570408865], "value": 20197.59667398927, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.80232267607465, 371.91631882826385, 376.64783427495286, 382.50656652917735, 399.13786221760984, 19871.25385164729, 20624.968751562436, 21102.577948441023, 21931.01310441032, 22090.11639534421, 20393.286234981777, 20566.69149962752, 21162.25932092373, 21234.920936464205, 21474.355769326907, 5225.634205605609, 5939.67331796751, 5948.940510594904, 6116.938830611682, 6123.234595675541, 4200.201961627281, 4451.955480445186, 6055.788047418341, 6162.95229810931, 6166.537509686769, 4372.8032238549185, 4391.516933137353, 4393.0994146199955, 6741.561798483083, 6796.558223715443, 5781.161731548902, 6768.0, 6794.76218332356, 6797.966010169967, 6810.114685090956, 5861.765529378819, 5968.074948383008, 5970.820875373745, 5981.7308221129715, 5984.0, 13114.278714670689, 16791.83208167915, 18965.24139034437, 25321.746782532307, 25650.87174564134, 1783.3847322673657, 2146.62434074038, 2161.070739581979, 2319.5360927814336, 2376.5484557933937, 10280.12618927392, 11070.557177712883, 12976.740465190738, 13783.96620253485, 16174.35302587895, 1853.8702290839647, 1854.3973208707225, 1860.1815201311379, 1893.6686079935955, 1904.628597423503, 126287.0, 129979.0, 133100.0, 134685.3265733665, 137228.70954266086, 10115.44365059914, 11608.941955290338, 11676.299422034705, 11702.76594468106, 11878.584249551397, 14709.632259193391, 14734.263286835616, 14741.0, 14749.77875331871, 14758.92620536912, 7139.857202855914, 8454.32365410778, 8605.698800542075, 8658.567071646392, 8739.475631462132, 8487.533185674847, 8488.787780305418, 8533.53065581399, 8672.392932494664, 8711.869321960176, 4478.373027776114, 4499.887502812456, 4509.1658043262105, 4527.796249168795, 4572.177008138567, 1716.3392094043884, 1813.3471950097953, 1853.342063567441, 1898.1932678611536, 1906.1517624656894, 696.6690821859576, 774.2219069834892, 836.7447928381902, 854.2994744309607, 872.583834288765, 19940.50148746293, 20653.380398588066, 21598.56802863934, 21704.023318950683, 21718.891405542872, 905.7826121730869, 907.5326207003399, 934.2899396458605, 980.3480685344166, 1045.1482042135788, 10857.67426977192, 11175.21773475849, 11366.545338186379, 11426.542938282542, 11478.311301321948, 630944.0, 637875.0, 640590.0, 649474.0, 652625.0, 116066.0, 117920.8207917927, 123538.0, 126177.0, 149203.0, 981.474910922653, 1001.0290018681867, 1001.2490632025834, 1002.2983911262146, 1008.8133695266399, 18691.90654046721, 18906.905465473134, 19438.028098595296, 19442.8055719441, 19493.70759438581, 54770.17844732412, 56433.43566564282, 57709.0, 59320.70339648447, 59699.20902372936, 85437.0, 86555.0, 88103.55948220218, 88396.0, 89214.21571568403, 7746.961265193863, 8054.677812887653, 8204.917950820416, 8294.170582941657, 8398.0, 9089.181973622406, 12514.499420023098, 13207.933960330136, 13278.668033299246, 13980.650483737987, 5532.004239236815, 7411.7035318588805, 11510.223257348442, 11891.76216475683, 11927.045836333245, 10633.255672102878, 11445.084393248686, 11505.769884602429, 11737.823932640846, 12085.516579336729, 11477.311361318347, 11581.247218930743, 12040.157188996685, 12056.095792815398, 12168.513259469877, 7163.928360716326, 7393.741219057522, 7477.878318252306, 8032.236937490929, 8449.493030418194, 8302.169783021649, 10185.592576296865, 11538.82691759641, 11704.648860534198, 11935.880641193477], "value": 9611.840834883757, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1508.2911031815047, 1520.5286361228018, 1686.84818366347, 1823.4803081121865, 1855.2671694680594, 8452.154784521545, 9023.18791308782, 9026.954865225682, 9040.68357607483, 9043.140901614353, 7867.291943725064, 8049.637766300516, 8077.19228077192, 8466.407351485399, 8838.381313308071, 2360.9527809443844, 2411.8311718179734, 2415.9637605435933, 2417.7944874685586, 2421.9515609687796, 2383.5709572276983, 2387.6060450025725, 2392.7248366437907, 2423.4789520253144, 2423.6970378702663, 2073.1707317073215, 2396.7483414241515, 2411.7105947286263, 2419.661247425362, 2422.551827911842, 2000.3898810862681, 2364.9881750591308, 2389.092144984912, 2389.175734371639, 2399.8440101393353, 2385.4155731845635, 2393.712754469475, 2394.856308621488, 2396.724376696667, 2398.59223931932, 8901.73294801157, 8920.330975176888, 9007.144321289466, 9019.188273055457, 9029.729108126767, 5367.114426119686, 5519.420460851633, 5530.225768392428, 5537.197106419547, 5546.223528705985, 3479.1302174456387, 3556.2176321209295, 3683.1344634010984, 3684.797336146511, 3690.5940346561856, 1047.6699839550517, 1072.3351522056298, 1080.1412876762993, 1100.5047728522118, 1101.3061771084247, 12003.819942700778, 12205.20666156706, 12210.877891221064, 12211.877881221162, 12254.877451225462, 4749.976250118727, 4796.7881593336015, 4822.614190864722, 4896.877578060506, 4926.236433352836, 10285.537150828231, 10286.228532860065, 10289.22830787694, 10292.742681432874, 10303.330283531546, 5503.394626591072, 5507.394186639466, 5510.834674959758, 5519.31008623922, 5526.723663816873, 4511.751853648081, 4626.398568186114, 4933.555979961749, 5030.0, 5031.119554078022, 4002.219567184371, 4002.5797291284, 4027.35562310029, 4116.320807066861, 4121.814518346681, 1281.9167803206276, 1283.0120806978575, 1293.8770816772392, 1298.214580178997, 1309.3453273363318, 744.1702501710554, 805.7341077444429, 815.8205194857122, 852.6205838401852, 889.9777505562413, 5709.68596727184, 5753.453421924911, 6008.729607167688, 6096.878062438726, 6218.129461875341, 922.9077092290718, 948.5162567090833, 955.350361754, 960.8798900137483, 982.8378317577663, 3893.201893611803, 3995.1610161866333, 4009.358502639622, 4029.2545879012478, 4110.403991421227, 10682.51928663212, 11192.10463162945, 11212.775744485065, 11220.831687524693, 11232.663020109247, 11111.388873611868, 11129.165312601588, 11132.38771867555, 11135.164862635334, 11140.721481962853, 8022.197780222048, 8287.673972164424, 8404.537750423786, 8405.495670259805, 8523.872141917876, 5992.280926288873, 6017.765980185948, 6024.457798798129, 6072.0, 6234.657093859882, 10194.827594826393, 10244.948775256076, 10495.790084198426, 10509.159267258754, 10522.789544209227, 10095.7476063099, 10421.68734937953, 10470.424126673106, 10611.734706632087, 10633.415162165846, 6881.8967715485305, 7041.119860017498, 7044.6125463100025, 7729.961350193213, 7881.0, 8270.627821748156, 8552.401331906707, 8558.400911936355, 8675.739727808175, 8685.869711954452, 7589.6584653689615, 7704.383649308154, 7704.730334438268, 7846.686132554634, 7859.17478664732, 7457.366123879531, 7515.060617422822, 7532.43506736986, 7534.434917381109, 7561.0, 6982.231954484901, 7087.574745515286, 7099.751508697171, 7129.893051604126, 7133.3936615388275, 4936.864521160225, 5006.07387633289, 5045.571126454292, 5098.974505127599, 5255.0, 5042.495750424928, 5065.493450654905, 5073.746312684425, 5120.283160357628, 5263.157894736823], "value": 4674.284267522019, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [254.26644131680104, 266.91897813853893, 300.87363307410885, 304.95883055787476, 318.37598307317654, 4570.497245303014, 5076.79692812288, 5311.362636483627, 5340.839774806752, 5378.946210537893, 4258.40382346471, 5006.924896126552, 5194.480551944804, 5238.397584277809, 5259.395169555502, 3386.3904497190497, 4012.294774720747, 4022.034711669208, 4064.4512990746316, 4110.383442483629, 3320.7841490303053, 3434.055634700452, 3762.341590221714, 3873.4577159197593, 4045.858394956177, 3358.4122778513783, 3946.5264168299846, 3969.364901615742, 4039.1921615676983, 4063.5936406359274, 3375.8480868360984, 3377.3751855906735, 3626.764260323084, 4021.954291884102, 4070.69469789764, 3008.022392722374, 3513.2095278562374, 3519.296140771856, 3520.4861909378956, 3526.6825985661158, 3926.7225009494423, 4283.507396649394, 4547.976705241294, 4929.162042452792, 4987.551120399182, 4268.722533035343, 4496.953885981903, 4566.817327306904, 4566.88582785433, 4660.0, 4854.223324268136, 5577.24316840194, 5583.994880921433, 5597.104463285855, 5612.831615051514, 3693.559511790404, 3842.9231415371814, 3845.8464059471244, 3859.9771060668945, 3868.2843673920415, 5520.23988005997, 5779.479846813807, 5841.591088623798, 5845.849446892711, 5873.500752436048, 3415.334009868052, 3439.793612383265, 3876.0, 3881.4565960765517, 3906.648401643866, 3513.5783705954937, 3966.424868394067, 3966.643002129822, 3971.2653159165648, 3991.44119823225, 3838.673712734449, 4357.760323182192, 4372.562743725665, 4514.525974772601, 4518.909621807546, 4767.380240568773, 5484.725763711798, 5584.609077364546, 5595.244641973363, 5661.829375549705, 1185.466540056978, 1257.874202588678, 1289.935503224835, 1292.9418176182094, 1310.974544329014, 858.6737039924789, 887.8313120507083, 899.347972719786, 903.2593273515786, 906.0984320601044, 3907.023244188953, 4768.47546769855, 4905.0, 4911.975440122848, 4984.501549844987, 4365.563443655609, 5067.467915868854, 5434.592405569598, 5661.320641523043, 5730.226419433407, 4011.8997025074605, 4423.889402764957, 5187.2478490619405, 5210.244514545369, 5211.947880521222, 2980.2847316643847, 3013.433014832275, 3017.2909366298904, 3019.9547006794915, 3021.018169095053, 4919.852404427873, 5595.692236926927, 5954.255718035246, 5983.175131584821, 5996.4603185713495, 4812.425352436429, 5311.681299121988, 5840.445157710011, 5883.735231914488, 5900.350961394243, 5134.717590532557, 5905.822825315161, 5993.160957465958, 6060.42425969541, 6071.362506936796, 4579.404677391918, 4658.627309815274, 5119.74401279927, 5575.0522411191005, 5713.314402271588, 4699.694519856198, 5066.468020857904, 5448.972755136199, 5669.659820410789, 5695.145728140812, 5699.658020518782, 5812.512492504464, 5999.3100793407575, 6000.0, 6029.87940241184, 3702.6297370263837, 3780.716446266486, 3783.6405541473514, 3811.522510368283, 3833.8083095845654, 5530.866172434722, 5554.194641776839, 5641.37944826077, 5717.0, 5739.651181972316, 4650.837220697259, 5169.767360468863, 5411.863508663225, 5555.694436806015, 5581.014157425758, 4780.760961951958, 5407.891842163213, 5464.0, 5474.781008759605, 5532.806351777668, 5175.626595526774, 5186.688798672092, 5310.964361949383, 5405.972865155608, 5451.890962180813, 4610.423697037871, 5486.149646804752, 5518.586106041983, 5526.889462210653, 5540.695261760642, 5085.949140508696, 5375.596830237826, 5381.461853814744, 5381.596380271417, 5429.945700542944], "value": 3999.726161019777, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [680.5712401187249, 710.4174576846985, 750.1972889008763, 767.8579462799386, 822.3667775812622, 14873.47942822, 15375.308111134998, 15930.442434514795, 16028.51914442567, 16479.752803707925, 14383.92808035961, 14797.92601036996, 14804.40782368704, 14811.629709257248, 14817.703645927075, 685.6845850908588, 702.7751119641716, 705.1714235772972, 836.481381543444, 846.7586737779734, 833.3749687734199, 851.5274022917279, 853.2491407561338, 855.4140413816524, 862.3144600042949, 892.2861710631502, 893.3835653399166, 894.0790985285166, 896.6503063805121, 897.1387468030698, 709.8260926073093, 731.7146312937958, 890.1054440287502, 891.8439273127177, 893.1247377569986, 640.2253273539023, 649.0394216559471, 651.7034749189107, 654.3848782144769, 657.6645910585588, 14989.925050374679, 14995.95028348016, 15002.549923502313, 15021.399144034225, 15027.474038408713, 13668.248246346448, 13766.93116534421, 13784.379702913293, 13961.581152565439, 13998.160110393408, 10245.385276883337, 11379.632575155101, 11666.300021998708, 12110.515579376814, 12336.321502317369, 4490.259107247301, 4498.482674492442, 4584.839530616446, 4624.953750462486, 4634.443866735979, 121555.0, 124719.0, 126124.0, 130067.0, 130399.0, 10707.732306692395, 10856.674299771019, 10971.23201375896, 11018.063464605599, 11134.665960021212, 21268.468288292916, 21301.14795408166, 21331.68002479964, 21374.893125534585, 21689.891550542146, 7795.454318197785, 7832.451728379073, 7884.250996155471, 7889.053313602404, 7945.6027198640995, 4313.266744653416, 4319.07139964909, 4321.330193819963, 4561.817527298871, 4575.0, 3534.3638145134123, 3679.7608155469807, 3680.024793429743, 3686.944695829565, 3689.612590677994, 658.2594581096266, 658.7760161545098, 660.923993740726, 666.5167753378762, 667.259342130235, 526.4235661950158, 546.1561886884773, 581.8312689320135, 583.614814222611, 647.2200997797643, 8220.383471239562, 8888.511131887679, 8910.287177025823, 9029.051949545334, 9128.726138215865, 569.8005698005664, 590.3594599859115, 607.3501353551658, 607.471499795181, 623.6351734235523, 4241.066965267636, 4318.827246910151, 4333.609975102256, 4375.5405682403525, 4510.300903359985, 160427.0, 161005.19497402437, 162024.0, 163762.0, 164614.17692911698, 138423.11595789282, 141281.5871841289, 141692.0, 143020.0, 143258.0, 117516.64966700618, 122827.0, 123862.14206786905, 125207.0, 125584.0, 8140.633671484916, 8302.54336011501, 8442.873356899529, 8602.923556194673, 8676.566171691517, 65291.673541633885, 66175.0, 66519.66740166461, 66697.0, 69247.0, 70096.0, 79060.0, 94758.0, 97926.0, 100149.99850001407, 12963.962882969152, 13102.868971310165, 13328.33358332099, 13337.599872003855, 13559.728805424034, 14323.57029289123, 14719.55841324762, 14926.925365373103, 14941.551753447415, 15279.923600381928, 13462.46150154022, 13716.0, 14106.717865642424, 14128.576142715736, 14163.787543186654, 13731.794023089462, 13810.516631917835, 13859.584212473643, 14057.0, 14089.647758806112, 13474.326283685972, 13737.24445155526, 13764.65588360299, 13920.791188132389, 14001.719965600834, 10173.694789156338, 11130.158381104246, 11233.38216398106, 11574.363410012193, 11942.462589183333, 11501.654950351503, 11645.308675011753, 11662.766744665229, 11693.473793679135, 11729.47217375203], "value": 7880.390830896278, "unit": "score"}], "name": "dromaeo_css", "value": 7377.625616093526, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 112.0, 117.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 110.0, 109.0, 140.0, 110.0, 110.0, 120.0, 109.0, 140.0, 108.0], "value": 120.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 182.0, 184.0, 183.0, 180.0, 186.0, 184.0, 183.0, 183.0], "value": 183.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 61.0, 90.0, 63.0, 59.0, 59.0, 59.0, 83.0, 56.0], "value": 67.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 95.0, 69.0, 68.0, 68.0, 91.0, 67.0, 69.0, 90.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 87.0, 85.0, 85.0, 87.0, 135.0, 84.0, 88.0, 83.0], "value": 90.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 93.0, 93.0, 92.0, 92.0, 93.0, 92.0, 94.0, 100.0], "value": 93.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 102.0, 141.0, 85.0, 85.0, 87.0, 83.0, 85.0, 84.0, 86.0], "value": 92.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 53.0, 53.0, 53.0, 58.0, 57.0, 58.0, 58.0, 58.0, 58.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 66.0, 73.0, 74.0, 71.0, 69.0, 69.0, 71.0, 70.0, 71.0], "value": 70.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 85.0, 82.0, 83.0, 83.0, 85.0, 86.0, 91.0, 90.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 137.0, 155.0, 126.0, 136.0, 134.0, 141.0, 143.0, 169.0, 136.0], "value": 141.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 162.0, 163.0, 162.0, 163.0, 161.0, 163.0, 165.0, 212.0], "value": 167.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 67.0, 65.0, 65.0, 68.0, 66.0, 67.0, 66.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1424.7, "alertThreshold": 2.0}]} 16:35:14 INFO - Return code: 0 16:35:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:35:14 INFO - # TBPL SUCCESS # 16:35:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:35:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:35:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:35:14 INFO - 2016-10-10 16:35:14.459 screenresolution[2312:23885] starting screenresolution argv=screenresolution get 16:35:14 INFO - 2016-10-10 16:35:14.461 screenresolution[2312:23885] Display 0: 1600x1200x32@60 16:35:14 INFO - 2016-10-10 16:35:14.467 screenresolution[2313:23888] starting screenresolution argv=screenresolution list 16:35:14 INFO - Available Modes on Display 0 16:35:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:35:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:35:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:35:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:35:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:35:14 INFO - Intel Iris: 16:35:14 INFO - Chipset Model: Intel Iris 16:35:14 INFO - Type: GPU 16:35:14 INFO - Bus: Built-In 16:35:14 INFO - VRAM (Dynamic, Max): 1536 MB 16:35:14 INFO - Vendor: Intel (0x8086) 16:35:14 INFO - Device ID: 0x0a2e 16:35:14 INFO - Revision ID: 0x0009 16:35:14 INFO - Displays: 16:35:14 INFO - Display: 16:35:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:35:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:35:14 INFO - Display Serial Number: 1600x1200 60 16:35:14 INFO - Main Display: Yes 16:35:14 INFO - Mirror: Off 16:35:14 INFO - Online: Yes 16:35:14 INFO - Rotation: Supported 16:35:14 INFO - Return code: 0 16:35:14 INFO - Running post-action listener: _resource_record_post_action 16:35:14 INFO - [mozharness: 2016-10-10 23:35:14.703047Z] Finished run-tests step (success) 16:35:14 INFO - Running post-run listener: _resource_record_post_run 16:35:14 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 315392; Write bytes: 661091840; Read time: 5; Write time: 1839 16:35:14 INFO - TinderboxPrint: CPU usage
53.3% 16:35:14 INFO - TinderboxPrint: I/O read bytes / time
315,392 / 5 16:35:14 INFO - TinderboxPrint: I/O write bytes / time
661,091,840 / 1,839 16:35:14 INFO - TinderboxPrint: CPU idle
2,255.0 (46.7%) 16:35:14 INFO - TinderboxPrint: CPU system
967.1 (20.0%) 16:35:14 INFO - TinderboxPrint: CPU user
1,607.7 (33.3%) 16:35:14 INFO - TinderboxPrint: Swap in / out
362,786,816 / 0 16:35:14 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 362260992; Write bytes: 356939264; Read time: 27717; Write time: 633 16:35:14 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 159744; Write bytes: 293826560; Read time: 2; Write time: 1171 16:35:15 INFO - Running post-run listener: _upload_blobber_files 16:35:15 INFO - Blob upload gear active. 16:35:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:35:15 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 16:35:15 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'] 16:35:15 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 16:35:15 INFO - (blobuploader) - INFO - Open directory for files ... 16:35:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:35:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:35:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:35:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:35:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:35:16 INFO - (blobuploader) - INFO - Done attempting. 16:35:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:35:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:35:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:35:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:35:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:35:17 INFO - (blobuploader) - INFO - Done attempting. 16:35:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:35:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:35:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:35:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:35:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:35:19 INFO - (blobuploader) - INFO - Done attempting. 16:35:19 INFO - (blobuploader) - INFO - Iteration through files over. 16:35:19 INFO - Return code: 0 16:35:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:35:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:35:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0684e35884146fef3e1128846bb74a360270e76205fcd3352c159a2cf52b98d36d43d6c2b8dc34f6fca54d4be6fdc1ca3c97aa904530f7ab791f87d40d19a681", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/58ba12ff299f4095a54aff5a53fca4021342f1ec75cd4594a06d5baad1b227f45360e639cf9de5a39fe2bef5ae3efd95a808fe031d92637e6234202b667bc1e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/473b19c3c942d93b7c514c209c0e98231c38c305436036b494fe41ae5fe1ec51c95347d7e92f0c9894d872d35a6a1d69b2926b92961388d85ea84be7b0dfdcf1"} 16:35:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:35:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:35:19 INFO - Contents: 16:35:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0684e35884146fef3e1128846bb74a360270e76205fcd3352c159a2cf52b98d36d43d6c2b8dc34f6fca54d4be6fdc1ca3c97aa904530f7ab791f87d40d19a681", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/58ba12ff299f4095a54aff5a53fca4021342f1ec75cd4594a06d5baad1b227f45360e639cf9de5a39fe2bef5ae3efd95a808fe031d92637e6234202b667bc1e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/473b19c3c942d93b7c514c209c0e98231c38c305436036b494fe41ae5fe1ec51c95347d7e92f0c9894d872d35a6a1d69b2926b92961388d85ea84be7b0dfdcf1"} 16:35:19 INFO - Running post-run listener: copy_logs_to_upload_dir 16:35:19 INFO - Copying logs to upload dir... 16:35:19 INFO - mkdir: /builds/slave/test/build/upload/logs 16:35:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.557990 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-10-10 16:35:19.582720) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 16:35:19.586901) ========= 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.QiCeGehpDW/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.Wdhmi4sr35/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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/0684e35884146fef3e1128846bb74a360270e76205fcd3352c159a2cf52b98d36d43d6c2b8dc34f6fca54d4be6fdc1ca3c97aa904530f7ab791f87d40d19a681", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/58ba12ff299f4095a54aff5a53fca4021342f1ec75cd4594a06d5baad1b227f45360e639cf9de5a39fe2bef5ae3efd95a808fe031d92637e6234202b667bc1e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/473b19c3c942d93b7c514c209c0e98231c38c305436036b494fe41ae5fe1ec51c95347d7e92f0c9894d872d35a6a1d69b2926b92961388d85ea84be7b0dfdcf1"} build_url:https://queue.taskcluster.net/v1/task/VaSC_-k4SxepVVmsZlDq1w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011681 build_url: 'https://queue.taskcluster.net/v1/task/VaSC_-k4SxepVVmsZlDq1w/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/0684e35884146fef3e1128846bb74a360270e76205fcd3352c159a2cf52b98d36d43d6c2b8dc34f6fca54d4be6fdc1ca3c97aa904530f7ab791f87d40d19a681", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/58ba12ff299f4095a54aff5a53fca4021342f1ec75cd4594a06d5baad1b227f45360e639cf9de5a39fe2bef5ae3efd95a808fe031d92637e6234202b667bc1e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/473b19c3c942d93b7c514c209c0e98231c38c305436036b494fe41ae5fe1ec51c95347d7e92f0c9894d872d35a6a1d69b2926b92961388d85ea84be7b0dfdcf1"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 16:35:19.627046) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 16:35:19.627520) ========= 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.QiCeGehpDW/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.Wdhmi4sr35/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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.005204 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 16:35:19.678424) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 16:35:19.678737) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 16:35:19.679058) ========= ========= Total master_lag: 0.20 =========