builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0343 starttime: 1471900277.92 results: success (0) buildid: 20160822115814 builduid: 6e0fb39ceddc459694091d773f50bc1d revision: cba664ef3a3ea8702508239b463fc8014bbb228b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 14:11:17.918368) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 14:11:17.918861) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 14:11:17.919144) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 14:11:17.947010) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 14:11:17.947377) ========= 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.MCZZinzfHY/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.iHuYDpgUbW/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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-08-22 14:11:17-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.7M=0.001s 2016-08-22 14:11:18 (18.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100037 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 14:11:18.073804) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 14:11:18.074151) ========= 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.MCZZinzfHY/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.iHuYDpgUbW/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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.025981 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 14:11:18.122485) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 14:11:18.122866) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cba664ef3a3ea8702508239b463fc8014bbb228b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev cba664ef3a3ea8702508239b463fc8014bbb228b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MCZZinzfHY/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.iHuYDpgUbW/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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-08-22 14:11:18,201 truncating revision to first 12 chars 2016-08-22 14:11:18,201 Setting DEBUG logging. 2016-08-22 14:11:18,201 attempt 1/10 2016-08-22 14:11:18,202 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cba664ef3a3e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 14:11:19,253 unpacking tar archive at: fx-team-cba664ef3a3e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.795298 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 14:11:19.944142) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 14:11:19.944463) ========= script_repo_revision: cba664ef3a3ea8702508239b463fc8014bbb228b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 14:11:19.944861) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 14:11:19.945132) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 14:11:19.964005) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-22 14:11:19.964406) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MCZZinzfHY/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.iHuYDpgUbW/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 14:11:20 INFO - MultiFileLogger online at 20160822 14:11:20 in /builds/slave/test 14:11:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:11:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:11:20 INFO - {'append_to_log': False, 14:11:20 INFO - 'base_work_dir': '/builds/slave/test', 14:11:20 INFO - 'blob_upload_branch': 'Fx-Team', 14:11:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:11:20 INFO - 'branch': 'Fx-Team', 14:11:20 INFO - 'buildbot_json_path': 'buildprops.json', 14:11:20 INFO - 'config_files': ('talos/mac_config.py',), 14:11:20 INFO - 'default_actions': ('clobber', 14:11:20 INFO - 'read-buildbot-config', 14:11:20 INFO - 'download-and-extract', 14:11:20 INFO - 'populate-webroot', 14:11:20 INFO - 'create-virtualenv', 14:11:20 INFO - 'install', 14:11:20 INFO - 'run-tests'), 14:11:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:11:20 INFO - 'download_minidump_stackwalk': True, 14:11:20 INFO - 'download_symbols': 'ondemand', 14:11:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:11:20 INFO - 'tooltool.py': '/tools/tooltool.py', 14:11:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:11:20 INFO - '/tools/misc-python/virtualenv.py')}, 14:11:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:11:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:11:20 INFO - 'installer_path': 'installer.exe', 14:11:20 INFO - 'log_level': 'info', 14:11:20 INFO - 'log_name': 'talos', 14:11:20 INFO - 'log_to_console': True, 14:11:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:11:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:11:20 INFO - 'opt_config_files': (), 14:11:20 INFO - 'pip_index': False, 14:11:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:11:20 INFO - 'cmd': ('bash', 14:11:20 INFO - '-c', 14:11:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:11:20 INFO - 'enabled': True, 14:11:20 INFO - 'halt_on_failure': False, 14:11:20 INFO - 'name': 'check_screen_resolution'},), 14:11:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:11:20 INFO - 'cmd': ('bash', 14:11:20 INFO - '-c', 14:11:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:11:20 INFO - 'enabled': True, 14:11:20 INFO - 'halt_on_failure': False, 14:11:20 INFO - 'name': 'check_screen_resolution'},), 14:11:20 INFO - 'run_cmd_checks_enabled': True, 14:11:20 INFO - 'sps_profile': False, 14:11:20 INFO - 'sps_profile_interval': 0, 14:11:20 INFO - 'suite': 'dromaeojs', 14:11:20 INFO - 'system_bits': '32', 14:11:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:11:20 INFO - 'title': 't-yosemite-r7-0343', 14:11:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:11:20 INFO - 'use_talos_json': True, 14:11:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:11:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:11:20 INFO - 'work_dir': 'build'} 14:11:20 INFO - [mozharness: 2016-08-22 21:11:20.156323Z] Running clobber step. 14:11:20 INFO - Running pre-action listener: _resource_record_pre_action 14:11:20 INFO - Running main action method: clobber 14:11:20 INFO - rmtree: /builds/slave/test/build 14:11:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:11:22 INFO - Running post-action listener: _resource_record_post_action 14:11:22 INFO - [mozharness: 2016-08-22 21:11:22.163135Z] Finished clobber step (success) 14:11:22 INFO - [mozharness: 2016-08-22 21:11:22.163300Z] Running read-buildbot-config step. 14:11:22 INFO - Running pre-action listener: _resource_record_pre_action 14:11:22 INFO - Running main action method: read_buildbot_config 14:11:22 INFO - Using buildbot properties: 14:11:22 INFO - { 14:11:22 INFO - "project": "", 14:11:22 INFO - "product": "firefox", 14:11:22 INFO - "script_repo_revision": "production", 14:11:22 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 14:11:22 INFO - "repository": "", 14:11:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 14:11:22 INFO - "buildid": "20160822115814", 14:11:22 INFO - "pgo_build": "False", 14:11:22 INFO - "basedir": "/builds/slave/test", 14:11:22 INFO - "buildnumber": 925, 14:11:22 INFO - "slavename": "t-yosemite-r7-0343", 14:11:22 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 14:11:22 INFO - "platform": "yosemite_r7", 14:11:22 INFO - "scheduler": "tests-fx-team-macosx64-talos", 14:11:22 INFO - "branch": "fx-team", 14:11:22 INFO - "repo_path": "integration/fx-team", 14:11:22 INFO - "revision": "cba664ef3a3ea8702508239b463fc8014bbb228b", 14:11:22 INFO - "stage_platform": "macosx64", 14:11:22 INFO - "builduid": "6e0fb39ceddc459694091d773f50bc1d", 14:11:22 INFO - "slavebuilddir": "test" 14:11:22 INFO - } 14:11:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/e5zgcQh1SM2Tm2ykKlQT5Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 14:11:22 INFO - Running post-action listener: _resource_record_post_action 14:11:22 INFO - [mozharness: 2016-08-22 21:11:22.166562Z] Finished read-buildbot-config step (success) 14:11:22 INFO - [mozharness: 2016-08-22 21:11:22.166656Z] Running download-and-extract step. 14:11:22 INFO - Running pre-action listener: _resource_record_pre_action 14:11:22 INFO - Running main action method: download_and_extract 14:11:22 INFO - mkdir: /builds/slave/test/build/tests 14:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:22 INFO - trying https://queue.taskcluster.net/v1/task/e5zgcQh1SM2Tm2ykKlQT5Q/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 14:11:22 INFO - Downloading https://queue.taskcluster.net/v1/task/e5zgcQh1SM2Tm2ykKlQT5Q/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 14:11:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e5zgcQh1SM2Tm2ykKlQT5Q/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 14:11:23 INFO - Downloaded 1199 bytes. 14:11:23 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 14:11:23 INFO - Using the following test package requirements: 14:11:23 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 14:11:23 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:11:23 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 14:11:23 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:11:23 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 14:11:23 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:11:23 INFO - u'jsshell-mac.zip'], 14:11:23 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:11:23 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 14:11:23 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 14:11:23 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:11:23 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 14:11:23 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:11:23 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 14:11:23 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:11:23 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 14:11:23 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:11:23 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 14:11:23 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:23 INFO - trying https://queue.taskcluster.net/v1/task/e5zgcQh1SM2Tm2ykKlQT5Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:11:23 INFO - Downloading https://queue.taskcluster.net/v1/task/e5zgcQh1SM2Tm2ykKlQT5Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:11:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e5zgcQh1SM2Tm2ykKlQT5Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:11:24 INFO - Downloaded 16352487 bytes. 14:11:24 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 14:11:31 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:11:31 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')]} 14:11:31 INFO - trying https://queue.taskcluster.net/v1/task/e5zgcQh1SM2Tm2ykKlQT5Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:11:31 INFO - Downloading https://queue.taskcluster.net/v1/task/e5zgcQh1SM2Tm2ykKlQT5Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:11:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e5zgcQh1SM2Tm2ykKlQT5Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:11:32 INFO - Downloaded 16352487 bytes. 14:11:32 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 14:11:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:38 INFO - trying https://queue.taskcluster.net/v1/task/e5zgcQh1SM2Tm2ykKlQT5Q/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 14:11:38 INFO - Downloading https://queue.taskcluster.net/v1/task/e5zgcQh1SM2Tm2ykKlQT5Q/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 14:11:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e5zgcQh1SM2Tm2ykKlQT5Q/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:11:39 INFO - Downloaded 14413981 bytes. 14:11:39 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 14:11: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')]} 14:11:40 INFO - trying https://queue.taskcluster.net/v1/task/e5zgcQh1SM2Tm2ykKlQT5Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:11:40 INFO - Downloading https://queue.taskcluster.net/v1/task/e5zgcQh1SM2Tm2ykKlQT5Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 14:11:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e5zgcQh1SM2Tm2ykKlQT5Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 14:11:42 INFO - Downloaded 111476664 bytes. 14:11:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e5zgcQh1SM2Tm2ykKlQT5Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:11:42 INFO - mkdir: /builds/slave/test/properties 14:11:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:11:42 INFO - Writing to file /builds/slave/test/properties/build_url 14:11:42 INFO - Contents: 14:11:42 INFO - build_url:https://queue.taskcluster.net/v1/task/e5zgcQh1SM2Tm2ykKlQT5Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:11:43 INFO - Running post-action listener: _resource_record_post_action 14:11:43 INFO - Running post-action listener: set_extra_try_arguments 14:11:43 INFO - [mozharness: 2016-08-22 21:11:43.618188Z] Finished download-and-extract step (success) 14:11:43 INFO - [mozharness: 2016-08-22 21:11:43.618325Z] Running populate-webroot step. 14:11:43 INFO - Running pre-action listener: _resource_record_pre_action 14:11:43 INFO - Running main action method: populate_webroot 14:11:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:11:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:11:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:11:43 INFO - '--tppagecycles', 14:11:43 INFO - '7'], 14:11:43 INFO - 'tests': ['tsvgm']}}, 14:11:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:11:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:11:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:11:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:11:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:11:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:11:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:43 INFO - 'talos_options': ['--disable-e10s'], 14:11:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:11:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:11:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:43 INFO - 'talos_options': ['--disable-e10s'], 14:11:43 INFO - 'tests': ['damp', 'tps']}, 14:11:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:43 INFO - 'tests': ['damp', 'tps']}, 14:11:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:11:43 INFO - 'tests': ['dromaeo_dom']}, 14:11:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:11:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:11:43 INFO - 'tests': ['basic_compositor_video']}, 14:11:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:11:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:11:43 INFO - 'tests': ['a11yr', 14:11:43 INFO - 'ts_paint', 14:11:43 INFO - 'tpaint', 14:11:43 INFO - 'sessionrestore', 14:11:43 INFO - 'sessionrestore_no_auto_restore', 14:11:43 INFO - 'tabpaint']}, 14:11:43 INFO - 'other-e10s': {'tests': ['a11yr', 14:11:43 INFO - 'ts_paint', 14:11:43 INFO - 'tpaint', 14:11:43 INFO - 'sessionrestore', 14:11:43 INFO - 'sessionrestore_no_auto_restore', 14:11:43 INFO - 'tabpaint']}, 14:11:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:11:43 INFO - 'ts_paint', 14:11:43 INFO - 'tpaint', 14:11:43 INFO - 'sessionrestore', 14:11:43 INFO - 'sessionrestore_no_auto_restore', 14:11:43 INFO - 'tabpaint']}, 14:11:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:11:43 INFO - 'ts_paint', 14:11:43 INFO - 'tpaint', 14:11:43 INFO - 'sessionrestore', 14:11:43 INFO - 'sessionrestore_no_auto_restore', 14:11:43 INFO - 'tabpaint']}, 14:11:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:11:43 INFO - 'tests': ['a11yr', 14:11:43 INFO - 'ts_paint', 14:11:43 INFO - 'tpaint', 14:11:43 INFO - 'sessionrestore', 14:11:43 INFO - 'sessionrestore_no_auto_restore', 14:11:43 INFO - 'tabpaint']}, 14:11:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:11:43 INFO - 'tests': ['a11yr', 14:11:43 INFO - 'ts_paint', 14:11:43 INFO - 'tpaint', 14:11:43 INFO - 'sessionrestore', 14:11:43 INFO - 'sessionrestore_no_auto_restore', 14:11:43 INFO - 'tabpaint']}, 14:11:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:11:43 INFO - 'tests': ['tsvgx', 14:11:43 INFO - 'tsvgr_opacity', 14:11:43 INFO - 'tart', 14:11:43 INFO - 'tscrollx', 14:11:43 INFO - 'cart']}, 14:11:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:11:43 INFO - 'tsvgr_opacity', 14:11:43 INFO - 'tart', 14:11:43 INFO - 'tscrollx', 14:11:43 INFO - 'cart']}, 14:11:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:43 INFO - 'talos_options': ['--disable-e10s'], 14:11:43 INFO - 'tests': ['tp5o']}, 14:11:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:43 INFO - 'tests': ['tp5o']}, 14:11:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:43 INFO - 'talos_options': ['--disable-e10s', 14:11:43 INFO - '--xperf_path', 14:11:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:11:43 INFO - 'tests': ['tp5n']}, 14:11:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:43 INFO - 'talos_options': ['--xperf_path', 14:11:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:11:43 INFO - 'tests': ['tp5n']}}, 14:11:43 INFO - 'talos.zip': {'path': '', 14:11:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:11:43 INFO - Running post-action listener: _resource_record_post_action 14:11:43 INFO - [mozharness: 2016-08-22 21:11:43.637402Z] Finished populate-webroot step (success) 14:11:43 INFO - [mozharness: 2016-08-22 21:11:43.637542Z] Running create-virtualenv step. 14:11:43 INFO - Running pre-action listener: _resource_record_pre_action 14:11:43 INFO - Running main action method: create_virtualenv 14:11:43 INFO - Creating virtualenv /builds/slave/test/build/venv 14:11:43 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 14:11:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:11:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:11:43 INFO - Using real prefix '/tools/python27' 14:11:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:11:44 INFO - Installing distribute.............................................................................................................................................................................................done. 14:11:47 INFO - Installing pip.................done. 14:11:47 INFO - Return code: 0 14:11:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:11: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')]} 14:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108544a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085d9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a4957c9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084a8d30>, '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 0x10820ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084a0b20>, '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.MCZZinzfHY/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.iHuYDpgUbW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 14:11: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', 'pip>=1.5'] in /builds/slave/test/build 14:11: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 pip>=1.5 14:11:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MCZZinzfHY/Render', 14:11:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:47 INFO - 'HOME': '/Users/cltbld', 14:11:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:47 INFO - 'LOGNAME': 'cltbld', 14:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:47 INFO - 'MOZ_NO_REMOTE': '1', 14:11:47 INFO - 'NO_EM_RESTART': '1', 14:11:47 INFO - 'PAGER': '/bin/cat', 14:11:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:47 INFO - 'PWD': '/builds/slave/test', 14:11:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:47 INFO - 'SHELL': '/bin/bash', 14:11:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iHuYDpgUbW/Listeners', 14:11:47 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 14:11:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:47 INFO - 'USER': 'cltbld', 14:11:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:47 INFO - 'XPC_FLAGS': '0x0', 14:11:47 INFO - 'XPC_SERVICE_NAME': '0', 14:11:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:47 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 14:11:47 INFO - Cleaning up... 14:11:47 INFO - Return code: 0 14:11:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:11: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')]} 14:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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', '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 0x108544a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085d9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a4957c9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084a8d30>, '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 0x10820ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084a0b20>, '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.MCZZinzfHY/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.iHuYDpgUbW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 14:11: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', 'psutil>=3.1.1'] in /builds/slave/test/build 14:11: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 psutil>=3.1.1 14:11:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MCZZinzfHY/Render', 14:11:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:47 INFO - 'HOME': '/Users/cltbld', 14:11:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:47 INFO - 'LOGNAME': 'cltbld', 14:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:47 INFO - 'MOZ_NO_REMOTE': '1', 14:11:47 INFO - 'NO_EM_RESTART': '1', 14:11:47 INFO - 'PAGER': '/bin/cat', 14:11:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:47 INFO - 'PWD': '/builds/slave/test', 14:11:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:47 INFO - 'SHELL': '/bin/bash', 14:11:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iHuYDpgUbW/Listeners', 14:11:47 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 14:11:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:47 INFO - 'USER': 'cltbld', 14:11:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:47 INFO - 'XPC_FLAGS': '0x0', 14:11:47 INFO - 'XPC_SERVICE_NAME': '0', 14:11:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:47 INFO - Downloading/unpacking psutil>=3.1.1 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:11:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:11:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:11:51 INFO - Installing collected packages: psutil 14:11:51 INFO - Running setup.py install for psutil 14:11:51 INFO - building 'psutil._psutil_osx' extension 14:11:51 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 14:11:51 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 14:11:51 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 14:11:51 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 14:11:51 INFO - building 'psutil._psutil_posix' extension 14:11:51 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 14:11:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:11:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:11:52 INFO - ^ 14:11:52 INFO - 1 warning generated. 14:11:52 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:11:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:11:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:11:52 INFO - Successfully installed psutil 14:11:52 INFO - Cleaning up... 14:11:52 INFO - Return code: 0 14:11:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:11:52 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')]} 14:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:52 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')]} 14:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:52 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 0x108544a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085d9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a4957c9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084a8d30>, '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 0x10820ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084a0b20>, '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.MCZZinzfHY/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.iHuYDpgUbW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 14:11:52 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 14:11:52 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 14:11:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MCZZinzfHY/Render', 14:11:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:52 INFO - 'HOME': '/Users/cltbld', 14:11:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:52 INFO - 'LOGNAME': 'cltbld', 14:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:52 INFO - 'MOZ_NO_REMOTE': '1', 14:11:52 INFO - 'NO_EM_RESTART': '1', 14:11:52 INFO - 'PAGER': '/bin/cat', 14:11:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:52 INFO - 'PWD': '/builds/slave/test', 14:11:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:52 INFO - 'SHELL': '/bin/bash', 14:11:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iHuYDpgUbW/Listeners', 14:11:52 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 14:11:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:52 INFO - 'USER': 'cltbld', 14:11:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:52 INFO - 'XPC_FLAGS': '0x0', 14:11:52 INFO - 'XPC_SERVICE_NAME': '0', 14:11:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:11:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:11:55 INFO - Installing collected packages: mozsystemmonitor 14:11:55 INFO - Running setup.py install for mozsystemmonitor 14:11:55 INFO - Successfully installed mozsystemmonitor 14:11:55 INFO - Cleaning up... 14:11:55 INFO - Return code: 0 14:11:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:11:55 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')]} 14:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:55 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')]} 14:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:55 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 0x108544a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085d9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a4957c9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084a8d30>, '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 0x10820ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084a0b20>, '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.MCZZinzfHY/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.iHuYDpgUbW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 14:11:55 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 14:11:55 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 14:11:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MCZZinzfHY/Render', 14:11:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:55 INFO - 'HOME': '/Users/cltbld', 14:11:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:55 INFO - 'LOGNAME': 'cltbld', 14:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:55 INFO - 'MOZ_NO_REMOTE': '1', 14:11:55 INFO - 'NO_EM_RESTART': '1', 14:11:55 INFO - 'PAGER': '/bin/cat', 14:11:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:55 INFO - 'PWD': '/builds/slave/test', 14:11:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:55 INFO - 'SHELL': '/bin/bash', 14:11:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iHuYDpgUbW/Listeners', 14:11:55 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 14:11:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:55 INFO - 'USER': 'cltbld', 14:11:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:55 INFO - 'XPC_FLAGS': '0x0', 14:11:55 INFO - 'XPC_SERVICE_NAME': '0', 14:11:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:55 INFO - Downloading/unpacking jsonschema==2.5.1 14:11:55 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 14:11:55 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 14:11:55 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 14:11:55 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 14:11:55 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 14:11:55 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 14:11:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:11:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:59 INFO - Downloading functools32-3.2.3-2.tar.gz 14:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:11:59 INFO - warning: no files found matching '*.txt' 14:11:59 INFO - no previously-included directories found matching 'build' 14:11:59 INFO - no previously-included directories found matching 'dist' 14:11:59 INFO - no previously-included directories found matching '.git*' 14:11:59 INFO - Installing collected packages: jsonschema, functools32 14:11:59 INFO - Running setup.py install for functools32 14:11:59 INFO - warning: no files found matching '*.txt' 14:11:59 INFO - no previously-included directories found matching 'build' 14:11:59 INFO - no previously-included directories found matching 'dist' 14:11:59 INFO - no previously-included directories found matching '.git*' 14:11:59 INFO - Successfully installed jsonschema functools32 14:11:59 INFO - Cleaning up... 14:11:59 INFO - Return code: 0 14:11:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108544a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085d9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a4957c9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084a8d30>, '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 0x10820ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084a0b20>, '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.MCZZinzfHY/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.iHuYDpgUbW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 14:11:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:11:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MCZZinzfHY/Render', 14:11:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:59 INFO - 'HOME': '/Users/cltbld', 14:11:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:59 INFO - 'LOGNAME': 'cltbld', 14:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:59 INFO - 'MOZ_NO_REMOTE': '1', 14:11:59 INFO - 'NO_EM_RESTART': '1', 14:11:59 INFO - 'PAGER': '/bin/cat', 14:11:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:59 INFO - 'PWD': '/builds/slave/test', 14:11:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:59 INFO - 'SHELL': '/bin/bash', 14:11:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iHuYDpgUbW/Listeners', 14:11:59 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 14:11:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:59 INFO - 'USER': 'cltbld', 14:11:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:59 INFO - 'XPC_FLAGS': '0x0', 14:11:59 INFO - 'XPC_SERVICE_NAME': '0', 14:11:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:11:59 INFO - Cleaning up... 14:11:59 INFO - Return code: 0 14:11:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108544a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085d9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a4957c9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084a8d30>, '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 0x10820ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084a0b20>, '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.MCZZinzfHY/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.iHuYDpgUbW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 14:11:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:11:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MCZZinzfHY/Render', 14:11:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:59 INFO - 'HOME': '/Users/cltbld', 14:11:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:59 INFO - 'LOGNAME': 'cltbld', 14:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:59 INFO - 'MOZ_NO_REMOTE': '1', 14:11:59 INFO - 'NO_EM_RESTART': '1', 14:11:59 INFO - 'PAGER': '/bin/cat', 14:11:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:59 INFO - 'PWD': '/builds/slave/test', 14:11:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:59 INFO - 'SHELL': '/bin/bash', 14:11:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iHuYDpgUbW/Listeners', 14:11:59 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 14:11:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:59 INFO - 'USER': 'cltbld', 14:11:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:59 INFO - 'XPC_FLAGS': '0x0', 14:11:59 INFO - 'XPC_SERVICE_NAME': '0', 14:11:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:00 INFO - Downloading/unpacking blobuploader==1.2.4 14:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:02 INFO - Downloading blobuploader-1.2.4.tar.gz 14:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:12:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:12: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 14:12: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 14:12: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 14:12: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 14:12: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 14:12: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 14:12:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:12:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:03 INFO - Downloading docopt-0.6.1.tar.gz 14:12:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:12:03 INFO - Installing collected packages: blobuploader, requests, docopt 14:12:03 INFO - Running setup.py install for blobuploader 14:12:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:12:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:12:04 INFO - Running setup.py install for requests 14:12:04 INFO - Running setup.py install for docopt 14:12:04 INFO - Successfully installed blobuploader requests docopt 14:12:04 INFO - Cleaning up... 14:12:04 INFO - Return code: 0 14:12:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:12:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108544a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085d9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a4957c9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084a8d30>, '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 0x10820ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084a0b20>, '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.MCZZinzfHY/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.iHuYDpgUbW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 14:12:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:12:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:12:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MCZZinzfHY/Render', 14:12:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:12:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:12:04 INFO - 'HOME': '/Users/cltbld', 14:12:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:12:04 INFO - 'LOGNAME': 'cltbld', 14:12:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:04 INFO - 'MOZ_NO_REMOTE': '1', 14:12:04 INFO - 'NO_EM_RESTART': '1', 14:12:04 INFO - 'PAGER': '/bin/cat', 14:12:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:12:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:04 INFO - 'PWD': '/builds/slave/test', 14:12:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:12:04 INFO - 'SHELL': '/bin/bash', 14:12:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iHuYDpgUbW/Listeners', 14:12:04 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 14:12:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:12:04 INFO - 'USER': 'cltbld', 14:12:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:12:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:12:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:04 INFO - 'XPC_FLAGS': '0x0', 14:12:04 INFO - 'XPC_SERVICE_NAME': '0', 14:12:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:12:05 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-8PUOEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:12:05 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-lo7G9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:12:05 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-zMg_UU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:12:05 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-qGbHUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:12:05 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-AcTRiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:12:05 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-BTPNHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:12:05 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-MbSVNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:12:05 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-k0EDd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:12:05 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-CWmQlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:12:05 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-YBG6QS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:12:06 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-LoTWNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:12:06 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-eqdvcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:12:06 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-fDXZCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:12:06 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-MXcGre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:12:06 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-5PtRqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:12:06 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-HnfU7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:12:06 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-RXpVWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:12:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:12:06 INFO - Running setup.py install for manifestparser 14:12:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:12:06 INFO - Running setup.py install for mozcrash 14:12:07 INFO - Running setup.py install for mozdebug 14:12:07 INFO - Running setup.py install for mozdevice 14:12:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:12:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:12:07 INFO - Running setup.py install for mozfile 14:12:07 INFO - Running setup.py install for mozhttpd 14:12:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:12:07 INFO - Running setup.py install for mozinfo 14:12:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:12:07 INFO - Running setup.py install for mozInstall 14:12:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:12:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:12:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:12:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:12:07 INFO - Running setup.py install for mozleak 14:12:08 INFO - Running setup.py install for mozlog 14:12:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:12:08 INFO - Running setup.py install for moznetwork 14:12:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:12:08 INFO - Running setup.py install for mozprocess 14:12:08 INFO - Running setup.py install for mozprofile 14:12:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:12:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:12:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:12:08 INFO - Running setup.py install for mozrunner 14:12:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:12:08 INFO - Running setup.py install for mozscreenshot 14:12:09 INFO - Running setup.py install for moztest 14:12:09 INFO - Running setup.py install for mozversion 14:12:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:12:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:12:09 INFO - Cleaning up... 14:12:09 INFO - Return code: 0 14:12:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:12:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108544a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085d9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a4957c9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084a8d30>, '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 0x10820ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084a0b20>, '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.MCZZinzfHY/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.iHuYDpgUbW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 14:12:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:12:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:12:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MCZZinzfHY/Render', 14:12:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:12:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:12:09 INFO - 'HOME': '/Users/cltbld', 14:12:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:12:09 INFO - 'LOGNAME': 'cltbld', 14:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:09 INFO - 'MOZ_NO_REMOTE': '1', 14:12:09 INFO - 'NO_EM_RESTART': '1', 14:12:09 INFO - 'PAGER': '/bin/cat', 14:12:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:09 INFO - 'PWD': '/builds/slave/test', 14:12:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:12:09 INFO - 'SHELL': '/bin/bash', 14:12:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iHuYDpgUbW/Listeners', 14:12:09 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 14:12:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:12:09 INFO - 'USER': 'cltbld', 14:12:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:12:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:09 INFO - 'XPC_FLAGS': '0x0', 14:12:09 INFO - 'XPC_SERVICE_NAME': '0', 14:12:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:12:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:12:09 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-6vcqXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:12:09 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-70R_lq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:12:09 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)) 14:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:12:09 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-uvlFXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:12:09 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)) 14:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:12:09 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-4kNW87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:12:10 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-aQFtK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:12:10 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-fVHrAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:12:10 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-s_s0ot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:12:10 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-oBifSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:12:10 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-_H5AzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:12:10 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-TALJ4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 14:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:12:10 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-tHzskj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:12:10 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)) 14:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:12:10 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-FB3VZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:12:10 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)) 14:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:12:10 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-dqypCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:12:11 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-g4k_L8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:12:11 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)) 14:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:12:11 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-VVTcWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:12:11 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-zzQwxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:12:11 INFO - Running setup.py (path:/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/pip-AwQ7Dc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:12:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:14 INFO - Downloading blessings-1.6.tar.gz 14:12:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:12:14 INFO - Installing collected packages: blessings 14:12:14 INFO - Running setup.py install for blessings 14:12:14 INFO - Successfully installed blessings 14:12:14 INFO - Cleaning up... 14:12:14 INFO - Return code: 0 14:12:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:12:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:12:14 INFO - Reading from file tmpfile_stdout 14:12:14 INFO - Current package versions: 14:12:14 INFO - blessings == 1.6 14:12:14 INFO - blobuploader == 1.2.4 14:12:14 INFO - docopt == 0.6.1 14:12:14 INFO - functools32 == 3.2.3-2 14:12:14 INFO - jsonschema == 2.5.1 14:12:14 INFO - manifestparser == 1.1 14:12:14 INFO - mozInstall == 1.12 14:12:14 INFO - mozcrash == 0.17 14:12:14 INFO - mozdebug == 0.1 14:12:14 INFO - mozdevice == 0.48 14:12:14 INFO - mozfile == 1.2 14:12:14 INFO - mozhttpd == 0.7 14:12:14 INFO - mozinfo == 0.9 14:12:14 INFO - mozleak == 0.1 14:12:14 INFO - mozlog == 3.3 14:12:14 INFO - moznetwork == 0.27 14:12:14 INFO - mozprocess == 0.23 14:12:14 INFO - mozprofile == 0.28 14:12:14 INFO - mozrunner == 6.12 14:12:14 INFO - mozscreenshot == 0.1 14:12:14 INFO - mozsystemmonitor == 0.3 14:12:14 INFO - moztest == 0.7 14:12:14 INFO - mozversion == 1.4 14:12:14 INFO - psutil == 3.1.1 14:12:14 INFO - requests == 1.2.3 14:12:14 INFO - wsgiref == 0.1.2 14:12:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:12: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')]} 14:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:12:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:15 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 0x108544a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085d9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a4957c9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084a8d30>, '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 0x10820ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084a0b20>, '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.MCZZinzfHY/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.iHuYDpgUbW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 14:12:15 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 14:12:15 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 14:12:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MCZZinzfHY/Render', 14:12:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:12:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:12:15 INFO - 'HOME': '/Users/cltbld', 14:12:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:12:15 INFO - 'LOGNAME': 'cltbld', 14:12:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:15 INFO - 'MOZ_NO_REMOTE': '1', 14:12:15 INFO - 'NO_EM_RESTART': '1', 14:12:15 INFO - 'PAGER': '/bin/cat', 14:12:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:12:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:15 INFO - 'PWD': '/builds/slave/test', 14:12:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:12:15 INFO - 'SHELL': '/bin/bash', 14:12:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iHuYDpgUbW/Listeners', 14:12:15 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 14:12:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:12:15 INFO - 'USER': 'cltbld', 14:12:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:12:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:12:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:15 INFO - 'XPC_FLAGS': '0x0', 14:12:15 INFO - 'XPC_SERVICE_NAME': '0', 14:12:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:12:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:12:15 INFO - Cleaning up... 14:12:15 INFO - Return code: 0 14:12:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:12:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108544a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085d9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a4957c9e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084a8d30>, '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 0x10820ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084a0b20>, '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.MCZZinzfHY/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.iHuYDpgUbW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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 14:12:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:12:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MCZZinzfHY/Render', 14:12:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:12:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:12:15 INFO - 'HOME': '/Users/cltbld', 14:12:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:12:15 INFO - 'LOGNAME': 'cltbld', 14:12:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:15 INFO - 'MOZ_NO_REMOTE': '1', 14:12:15 INFO - 'NO_EM_RESTART': '1', 14:12:15 INFO - 'PAGER': '/bin/cat', 14:12:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:12:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:15 INFO - 'PWD': '/builds/slave/test', 14:12:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:12:15 INFO - 'SHELL': '/bin/bash', 14:12:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iHuYDpgUbW/Listeners', 14:12:15 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 14:12:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:12:15 INFO - 'USER': 'cltbld', 14:12:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:12:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:12:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:15 INFO - 'XPC_FLAGS': '0x0', 14:12:15 INFO - 'XPC_SERVICE_NAME': '0', 14:12:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:12:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:12:15 INFO - Cleaning up... 14:12:15 INFO - Return code: 0 14:12:15 INFO - Running post-action listener: _resource_record_post_action 14:12:15 INFO - Running post-action listener: _start_resource_monitoring 14:12:15 INFO - Starting resource monitoring. 14:12:15 INFO - [mozharness: 2016-08-22 21:12:15.763091Z] Finished create-virtualenv step (success) 14:12:15 INFO - [mozharness: 2016-08-22 21:12:15.764106Z] Running install step. 14:12:15 INFO - Running pre-action listener: _resource_record_pre_action 14:12:15 INFO - Running main action method: install 14:12:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:12:16 INFO - Reading from file tmpfile_stdout 14:12:16 INFO - Detecting whether we're running mozinstall >=1.0... 14:12:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:12:16 INFO - Reading from file tmpfile_stdout 14:12:16 INFO - Output received: 14:12:16 INFO - Usage: mozinstall [options] installer 14:12:16 INFO - Options: 14:12:16 INFO - -h, --help show this help message and exit 14:12:16 INFO - -d DEST, --destination=DEST 14:12:16 INFO - Directory to install application into. [default: 14:12:16 INFO - "/builds/slave/test"] 14:12:16 INFO - --app=APP Application being installed. [default: firefox] 14:12:16 INFO - mkdir: /builds/slave/test/build/application 14:12:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:12:50 INFO - Reading from file tmpfile_stdout 14:12:50 INFO - Output received: 14:12:50 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:12:50 INFO - Running post-action listener: _resource_record_post_action 14:12:50 INFO - [mozharness: 2016-08-22 21:12:50.056757Z] Finished install step (success) 14:12:50 INFO - [mozharness: 2016-08-22 21:12:50.056901Z] Running run-tests step. 14:12:50 INFO - Running pre-action listener: _resource_record_pre_action 14:12:50 INFO - Running main action method: run_tests 14:12:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:12:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:12:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:12:50 INFO - 2016-08-22 14:12:50.071 screenresolution[1638:7434] starting screenresolution argv=screenresolution get 14:12:50 INFO - 2016-08-22 14:12:50.074 screenresolution[1638:7434] Display 0: 1600x1200x32@60 14:12:50 INFO - 2016-08-22 14:12:50.079 screenresolution[1639:7436] starting screenresolution argv=screenresolution list 14:12:50 INFO - Available Modes on Display 0 14:12:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:12:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:12:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:12:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:12:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:12:50 INFO - Intel Iris: 14:12:50 INFO - Chipset Model: Intel Iris 14:12:50 INFO - Type: GPU 14:12:50 INFO - Bus: Built-In 14:12:50 INFO - VRAM (Dynamic, Max): 1536 MB 14:12:50 INFO - Vendor: Intel (0x8086) 14:12:50 INFO - Device ID: 0x0a2e 14:12:50 INFO - Revision ID: 0x0009 14:12:50 INFO - Displays: 14:12:50 INFO - Display: 14:12:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:12:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:12:50 INFO - Display Serial Number: 1600x1200 60 14:12:50 INFO - Main Display: Yes 14:12:50 INFO - Mirror: Off 14:12:50 INFO - Online: Yes 14:12:50 INFO - Rotation: Supported 14:12:50 INFO - Return code: 0 14:12:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:12:50 INFO - Python 2.7.3 14:12:50 INFO - Return code: 0 14:12:50 INFO - grabbing minidump binary from tooltool 14:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:12:50 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 0x1084a8d30>, '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 0x10820ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084a0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:12:50 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 14:12:50 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 14:12:50 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 14:12:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:12:50 INFO - Return code: 0 14:12:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:12:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:12:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:12:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:12:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:12:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e5zgcQh1SM2Tm2ykKlQT5Q/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0343', '--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 14:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e5zgcQh1SM2Tm2ykKlQT5Q/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0343 --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 14:12:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MCZZinzfHY/Render', 14:12:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:12:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:12:50 INFO - 'HOME': '/Users/cltbld', 14:12:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:12:50 INFO - 'LOGNAME': 'cltbld', 14:12:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:12:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:50 INFO - 'MOZ_NO_REMOTE': '1', 14:12:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:12:50 INFO - 'NO_EM_RESTART': '1', 14:12:50 INFO - 'PAGER': '/bin/cat', 14:12:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:50 INFO - 'PWD': '/builds/slave/test', 14:12:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:12:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:12:50 INFO - 'SHELL': '/bin/bash', 14:12:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iHuYDpgUbW/Listeners', 14:12:50 INFO - 'TMPDIR': '/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/', 14:12:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:12:50 INFO - 'USER': 'cltbld', 14:12:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:12:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:50 INFO - 'XPC_FLAGS': '0x0', 14:12:50 INFO - 'XPC_SERVICE_NAME': '0', 14:12:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:12:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e5zgcQh1SM2Tm2ykKlQT5Q/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0343', '--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 14:12:50 INFO - mozversion application_buildid: 20160822115814 14:12:50 INFO - mozversion application_changeset: cba664ef3a3ea8702508239b463fc8014bbb228b 14:12:50 INFO - mozversion application_display_name: Nightly 14:12:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:12:50 INFO - mozversion application_name: Firefox 14:12:50 INFO - mozversion application_remotingname: firefox 14:12:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:12:50 INFO - mozversion application_vendor: Mozilla 14:12:50 INFO - mozversion application_version: 51.0a1 14:12:50 INFO - mozversion platform_buildid: 20160822115814 14:12:50 INFO - mozversion platform_changeset: cba664ef3a3ea8702508239b463fc8014bbb228b 14:12:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:12:50 INFO - mozversion platform_version: 51.0a1 14:12:50 INFO - using testdate: 1471900370 14:12:50 INFO - actual date: 1471900370 14:12:50 INFO - starting webserver on 'localhost:49276' 14:12:50 INFO - SUITE-START | Running 2 tests 14:12:50 INFO - TEST-START | dromaeo_css 14:12:50 INFO - operating with platform_type : mac_ 14:12:50 INFO - Initialising browser for dromaeo_css test... 14:12:50 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/tmpg9dNUp/profile http://localhost:49276/getInfo.html) 14:12:53 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 14:12:53 INFO - PROCESS | 1649 | colorDepth:24 14:12:53 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 14:12:53 INFO - PROCESS | 1649 | __metrics 14:12:53 INFO - PROCESS | 1649 | 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" 14:12:53 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:12:53 INFO - TEST-INFO | 1649: exit 0 14:12:53 INFO - Browser initialized. 14:12:53 INFO - Running cycle 1/1 for dromaeo_css test... 14:12:53 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/tmpg9dNUp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:13:05 INFO - PROCESS | 1651 | RSS: Main: 228614144 14:13:05 INFO - PROCESS | 1651 | 14:13:56 INFO - PROCESS | 1651 | 1471900436590 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] 14:16:08 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 14:16:09 INFO - PROCESS | 1651 | RSS: Main: 317464576 14:16:09 INFO - PROCESS | 1651 | 14:19:12 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 14:19:13 INFO - PROCESS | 1651 | RSS: Main: 384004096 14:19:13 INFO - PROCESS | 1651 | 14:22:15 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 14:22:16 INFO - PROCESS | 1651 | RSS: Main: 343199744 14:22:16 INFO - PROCESS | 1651 | 14:25:18 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 14:25:19 INFO - PROCESS | 1651 | RSS: Main: 358309888 14:25:19 INFO - PROCESS | 1651 | 14:28:22 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 14:28:23 INFO - PROCESS | 1651 | RSS: Main: 327700480 14:28:23 INFO - PROCESS | 1651 | 14:31:26 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 14:31:26 INFO - PROCESS | 1651 | RSS: Main: 454709248 14:31:26 INFO - PROCESS | 1651 | 14:31:26 INFO - PROCESS | 1651 | __start_tp_report 14:31:26 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 14:31:26 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 14:31:26 INFO - PROCESS | 1651 | |i|pagename|runs| 14:31:26 INFO - PROCESS | 1651 | |0;dojo.html;2634.8550829704363;3354.4297469430194;3355.6141043779944;3356.7985920844735;3367.966320336796;5456.61803673743;5525.778968841241;5556.9444305556935;5629.7185140743;5651.717414129293;5538.6399884007515;5557.472040156189;5600.943990560093;5610.326760788711;5653.575981801371;5109.616778741591;5134.050200712862;5157.7936882524655;5181.404138524081;5222.686638801684;5213.713245771481;5273.551748101416;5283.445238249986;5285.180796976456;5287.206918962167;5039.697618142924;5185.040767458032;5187.092258854723;5223.112070947948;5223.320968274119;4595.954040459586;5030.723310217936;5037.5718063964605;5101.668391554537;5111.412187598399;5085.415177254589;5136.743162841843;5141.562967147797;5144.717040562768;5158.277841102249;5343.786248550054;5632.295963004624;5636.15457681347;5643.435656434365;5670.177824215466;5861.912071318934;6079.787207447718;6175.104609831549;6190.350013248589;6242.875142497124;5168.715720635363;6300.590461620026;6311.2426508819235;6316.684165791692;6320.146780184662;5756.740946657411;5767;5776.942230577724;5781.364049954502;5790.652560846363;6206.503479721611;6272.5922815016875;6331.176946996861;6332.081848131995;6363.331850155667;6029.60807547508;6095.05526643371;6100.572959892765;6113.816585502442;6118.724657390339;6154.876902462015;6248.656323902229;6249.812505624838;6253.218347706536;6263.780767673201;5932.762689492458;6057.666828324396;6098.847528811726;6109.236345456818;6180.783672571439;6228.5951413158;6239.750409983641;6247.219097612799;6249.0626406039455;6258.468030217391;4949.30709700635;4953.157963146274;4955.231939049453;4960.578350840146;4970.826021089245;4332.870013899588;4399.780010999437;4404.867853964386;4407.801648925806;4440.533743956838;5584.497395234448;5636.013697602903;5638.182463542763;5685.829425117253;5694.402087780806;6231.470325022424;6254;6281.089242059968;6294.181756371734;6309.053641953652;5512.145617429305;5609.298837645294;5681.801136960269;5683.8010669626365;5691.68695721731;5331.840044798662;5352.785888564414;5356;5415.241866138744;5438.864028399322;6293.465055470337;6321.873562528724;6323.841903952438;6350.396712312508;6356.237251529661;6300.21247344082;6307;6321.620702757849;6325.620462772248;6336.58812177207;6152.292486364126;6248;6317.778877739257;6329.303776584664;6344.524160688059;6136.846578835565;6176;6187.381261873957;6192.845178870384;6221.875562488634;6091.177691011657;6263.467605253422;6263.592866463665;6265.091561723616;6284.937150628435;5839.416058394127;5941.435563621449;6001.7299221536005;6030.396960303934;6103.115048318058;6060.909036373495;6067.575269731076;6071.726772295346;6087.847803804941;6091.695415229309;5822.126680997715;5837.94162058374;5858.179854820243;5861.32594751609;5873.530117590668;5803.042497987784;5904.143899134516;5909.763609455574;5935.109733540004;6064.909026364697;5792.565557583114;5827.766889324549;5863.794767183128;5864.501517371071;5864.618799778001 14:31:26 INFO - PROCESS | 1651 | |1;ext.html;461.7921935129191;472.5439950447818;491.2998976458548;528.9761960711768;541.6722882655993;30630.54054189189;39252.80373598132;40283.992900177545;40357.79821100898;40423;42168.36747448791;42431.78784106083;42489.150216995644;42572.57427425725;42584.787076064575;9639.325247232697;9800.26498012652;9806.950965245163;9816.165625921769;9821.754456138582;9489.90510094897;9568.80862382752;9576.281778866578;9596.376235544667;9600.279979001569;9543.904560954406;9601.75995600112;9604.759881002996;9605.231581473501;9614.71155865325;9530.475823829687;9579.377340472882;9584.808303833885;9587.856182157204;9588.280878934107;9632.036796320383;9729.367591106555;9730.513474326326;9739.074787895139;9771.169450596708;39698.404523932164;40024;40093;40125.398119028236;40156.397654035216;3570.8571657133684;3608.729345299113;3618.6200448952745;3621.4567814827988;3842.8078596070086;25617.743822561722;30598.388032239454;31764.523532147035;31950.680493195236;32162.03513894587;3200.247941733691;3288.3423315337027;3289.3914625794305;3306.966930330714;3429.8285085745615;368469;370187.9999999973;371160;373062;374217.12891435367;33892.32215355679;34542.65457345445;56493.71753141208;56953.430465695645;57003.714981424826;34370;34610.82694586511;34658.82670586631;34730.65269347325;34742.82628586841;14705.926470367795;14863.70272594542;14870.628234294229;14871.553853384416;14891.925540372229;12606.49574017029;12666;12668.113232073667;12693.730626937233;12710.555130570385;7686.461947663722;7708.691652333844;7770.961145194238;7773.611319434119;7797.298243158029;3175.412548678502;3226.3708576827294;3230.951535726966;3236.8705251790134;3257.674232576723;818.5170749257848;939.2861425316809;1036.7610705207355;1060.0194819791661;1066.6746642274181;29396.265093372836;29852.402951941272;30158.396832063674;30545.93089241866;30764.53853192204;1048.4705223862054;1066.424130969268;1099.0328510910347;1124.4771181400688;1142.6457798082622;14873.256337183098;15195.392184312725;15499.457518986781;15905.920470397574;15933.601659958595;568670;691682;693666;694037;695397;57889.71055144697;58169;58224;58254.417455825744;58285;1213.2417239225483;1345.6299517632533;1349.4602159136227;1389.5692335376066;1396.8952328575601;29689.851550742973;29833.701662983094;30087;30229.421051578924;30521.847390762905;41393;49030.26454603255;49049.75475122601;49113.65067938388;49287.767805803705;556646;562362;562561;563028;563145;22546.323610291718;24748.87625561861;25152.371190719645;25549.61675574905;25580.976760930098;44970.100597987206;45036.54963450324;45195.774021131;45397.09205815799;45573.77213113913;36996;37311.253774924895;37707.62292377041;38507.80746096252;38573.614263857;36467.63532364643;36576.81711591425;36816.63183368132;37380;37560.43659345167;35156.64843351636;35208.471872921415;35265.82367088148;35334;35452.822735886155;31117.910873119334;31544.526832097996;33236;33504.99485015454;33673.15817104592;21155.576888462452;24452.633210501503;24541.509169816145;25025.368277406138;25217.747822522273 14:31:26 INFO - PROCESS | 1651 | |2;jquery.html;347.3019231344996;366.7909291703728;375.6243756243756;382.82964080983953;403.11516221892936;15801.604959875995;16042.117683527402;21477.174440172603;21925.23261685841;22208.88895555524;20559.588808223827;21261.57476850462;21726;22123.557528849455;22442.5214091816;5168.741562921858;6253.781117660883;7390.113186417638;7780.494267872598;7883.448158628869;4163.458750362449;7007.684654190548;7732.304092631662;7732.497387669811;7801.595712771699;4910;7719.72980945667;8113.066997295298;8125.187481251886;8147.592620368988;6820.942753873158;7384;8020.719274825382;8095.392845536549;8119.553424561646;7713.228677132298;7731.806704832424;7788.883166752503;7803.960980195119;7811.414143939171;29098.563521547192;29288.707112929023;29769.851150744325;29905.102846914626;29964.550531742043;2237.6867238586447;2430.6232533957264;2580.83224590401;2616.842989420622;2679.9196024119306;16471.34114635425;16559.68164456977;17425.1287435629;17592;17599.38402155931;1921.4427815933363;1977.1992343101067;1979.831714304286;1984.4145976936838;1990.6556984266426;140083;140112.89830652447;142097.2895135528;143022.28488857593;148345.258273709;21336.89331553332;21463.892680536497;21564.35306940794;21642.458938526346;21764.564708705737;35745.35310409682;35763.64236357655;35790;35805.46291805625;35845.82077089598;10776.461176941122;11078;11218;11251.94374028141;11456.885431145749;9176;9196.770080748034;9201.769955751026;9336;9366.29752768545;8400.907881975305;8456.704015359555;9214.663873738271;9702.320837541305;9896.901030989598;2671.452352267819;2979.6275465566805;3686.078480379905;3747.7376583638884;3784;692.4840993459904;796.2435686098114;812.0174588747682;862.2326129744532;1017.5370206555999;18351.632967340847;21464.356069317946;21997.780022199895;22031.559368812534;22207.888960555418;876.5266755951715;884.3323290915317;908.681961313535;925.0980294213089;956.5791051937125;10291.897081029243;10978.780424391467;11773.705657358463;11779.469923853447;11782.116341274439;588474;601842;614192;629071;629904;104161.47919260507;124596;127089.36455317664;128414;130750;935.6725146198776;961.5144352102144;987.511181964932;992.1417973452911;992.6823416506649;16181.838181618034;19435.61128777388;19751.40745777629;19769.011549422183;19843.206271749546;52451;52859.207111894124;53405;53791.731041344545;53968.65078372915;78848.60575697085;81624.5918770426;82975.585122074;84826;85823.57088214518;8024.799380015546;8147.388945828968;8288;8337;8473;12832.807507887203;13224.603261902159;13304.004399339789;13408.463661453432;13587.86412135866;9338.252939764938;10835.837462437912;11289.096872250364;11307.943460282646;11569.942150289195;9339.346245762732;11156.386398747822;11350.205485616258;11614.88385116138;11672.70818229551;11422.828657569977;11566.710832229262;11721.12091593117;11736.706582335168;11870.940645296718;8126.349892008507;8276.172382761675;8322.750317490485;8330.250277475056;8454.704085356983;11052.944735276273;11241.66275011751;11592.536298547964;11640;11697.23967942081 14:31:26 INFO - PROCESS | 1651 | |3;mootools.html;1455.1850963460463;1515.7271691095602;1644.4244514419947;1772.6631939931403;1821.5628249220192;8371.87442188367;8904.777380565489;8907.24288435483;8923.821523569524;8924.732258032262;7795.259450352208;7994.200579942003;8454.704085357014;8674.221784534155;8677.132286771319;2326.7091613548305;2349.9177528786495;2360.173939121311;2361.055577768898;2364.432536191319;2340.0990618611786;2352.635341522067;2387.128698025217;2388.22382725614;2395.8442701224367;2349.835511514195;2372.9881350593223;2373.9881300593474;2385.0936644075314;2393.1384701507445;2337.135259953811;2350.647402889572;2354.9058037678474;2361.0319768894756;2363.102021231921;2325.5813953488364;2347.624380099176;2349.259983105316;2353.646952957053;2355.5759963206615;8741.606627701769;8838.55807209637;8865.556722163867;8872.46765194084;8928.419652722552;5149.176131818891;5313.628046036779;5327.600429967729;5336;5339.279197308352;3569.5538057742783;3582.2119133790525;3642.1440961374055;3649.5255616769914;3655.0862284428895;1069.251523933242;1075.854759607451;1078.5470102556867;1089.7983872983443;1104.6244276945877;11494.885051149466;11609.955104040677;11612.303261804318;11621.53513859453;11621.76756464866;4487.618552423015;4629.097326021393;4733.834315798999;4737.644676649265;4777.689450185727;9859.161971232526;9867.950660246654;9871.210303175872;9871.654492092743;9891.653792117242;5316.46835316473;5328.706921119376;5333.893322133536;5346.144616861361;5347.786088556414;4360.389545463638;4516.570925762047;4725;4868.537488938545;4901.044296362175;3823.617638236154;3870.8838734838;3946.6053394660303;3984.780837053932;4031;1294.087668193921;1294.4757722441277;1303.0519373536624;1311.6851955530603;1315.6184706435026;881.7046289493092;921.7972046149837;927.2816007808735;937.4656445825814;978.9804203916025;5798.304203495608;5902.704864756831;6028.849278767978;6114.602550834182;6215.409536094064;422.4824589877376;442.38066706611;457.07442429081374;466.44493053266507;469.4648101164675;3252.1381833814057;4035.8183881725395;4037.172379662221;4099.200655872136;4156.314208155621;10180.949095254477;10507.579696812041;10537.10434613051;10671;10693.9465302673;10416.739581510372;10614.25700200994;10615.150787936947;10619.628313009007;10627.309224900357;7710.460267781202;8021.959890200512;8058.11360750317;8111.269985701315;8129.715459958873;5950.434708702666;6006.549508786946;6107.5724699272405;6228.065790131516;6250.906236406367;9875.753106172404;10065.24510661718;10118.797624047626;10137.036981486746;10154.44150571696;8774.517401542977;9769.706908792748;10272.33229840058;10319.742006449898;10365.585376584851;6156.445919867234;6904.723811047502;7120.216776154515;7485.663145158372;7631.236876312324;8120.228578285053;8183;8450.746477605682;8460.027096883938;8464;6650.733970641314;7429.517081389692;7480.476366654282;7549.5463974207505;7678.385729141543;7334.229905859808;7357.153927298215;7389.298016688406;7404.629768511661;7521.699132034657;6901.861962760616;7057.153141623038;7064.717411303696;7065.788026359218;7072.3634872861685;4599.770011499345;4858.663867436483;5030.899382012412;5071.644984851173;5115.386153661436;5026.974865125797;5032.370953630796;5143.819966301311;5165.715885626327;5246.213068039825 14:31:26 INFO - PROCESS | 1651 | |4;prototype.html;264.76618955666595;304.5659934593205;313.9968600313996;315.21825871837825;318.5333486442361;5322.707251101193;5338.759755810988;5343.812966546172;5356.4911333423315;5360.731963401824;4002.8170561762954;4744.837514808876;5279.392869819972;5295.655782374143;5300.257963885059;3839.178204020043;4068.6948478864056;4076.9592304077023;4079.9184016319805;4098.733582317155;3565.6969157621634;4104.994276402271;4107.67138628909;4108.198901214264;4121.5672354402805;3927.3519869221545;4018.799060046986;4037.4347591337237;4070.1656160487178;4096.078382363974;3948.4866967294356;3996.002997751686;4022.5776293489057;4026.4095682205657;4049;2791.469620772067;3282.7373810095137;3368.191634007845;3484.0767196692896;3521.3485505181366;4239.724417912826;4910.533499317559;5157.329547158845;5177.48225177483;5187.688738675692;3899.980500097481;4214.904124927541;4235.703500754948;4339.457567804025;4348.5216626171095;5165.612579056586;5232.529072383466;5561.746378368659;5568;5609.353919952023;3555.986543834995;3625.782453052825;3849.9797553648305;3866;3873.941890871611;5612.971935140339;5683.943160568383;5816.418358164192;5899.970500147515;5953.821385358447;3707.3141468828353;3729.291434627412;3739.8317075731657;3744.513213282256;3745.831437585315;3288.901332960015;3342.6490218526706;3934.626210510054;3941.7832019238645;3952;3888.3972984187494;4585.79363928624;4619.620895238954;4650.488591207803;4683.157031734252;5407.621056630534;5645.1532270159805;5659.603827732101;5715.771369145271;5741.770329186786;1084.4329943232112;1260.87391260875;1325.7348530293787;1341.7182391697852;1349.5748839115647;767.6353731977266;801.1973060613619;809.4900212865974;822.6051495282178;824.1593574553922;3882.0395700171234;4372.731907746782;4390.429244198233;4446.177457170369;4456.844010459618;3842.615738426135;4494.146217152132;4494.359568749258;4583.931241031387;4775.594074503637;3571.7321200910037;3723.515942927402;4206.497134205143;4234.6823988201;4394.890127746768;2504.5742223821994;2525.76237643557;3038;3088.98455507721;3102.860371283298;4666.766661666903;5862.941370586324;6019.578629495981;6050.606710563799;6050.969745151246;5198;5217.58259339252;5675.3757086720425;5881.5588830837005;6004;5999.400059994053;6009.716307803007;6051.7925499485345;6065.4541091302;6073.635581865014;4977.776000079933;5832.066869300891;5839.357670656309;5850.444207800252;5874.796951143321;5004.39947206323;5181.404138524118;5262.263283140287;5747.8563035924435;5761.798337058183;5113.897722045613;5490.286262785812;5690.174924635988;5714.599978001666;6059.697015149313;3601.675849173587;3844.000559854402;3876.244132394156;3880.9805950970062;3904.121572646132;4857.465678775261;5644.971775141098;5873.500752436091;5883.794067207627;5894.263217097863;5178.585713143015;5393.1461684484275;5447.291852059207;5594.0769772987005;5743.655380677173;4303.720258183208;4882.95117048825;5630.127330263816;5652.7173641318595;5667.631603945731;4449.488308844395;5491.752871120889;5525.502704756591;5527.585431092764;5555.083496193806;4947.109520286383;5320.946790532045;5487.368952570346;5560.777568897199;5613.438656134354;4825.710457372569;5143.099957507496;5417.160340147283;5538.612297139322;5545.251391062155 14:31:26 INFO - PROCESS | 1651 | |5;yui.html;595.2826843653397;736.9093741262927;778.58345785005;798.1180795221284;805.6334367862623;12286.938565307171;16439.58901027475;16463.588410289747;16465.506034818944;16475.340986360563;14633.780493292583;14873.553793386189;14898.40406383746;14902.105873647588;14999.625009374744;689.9034135221073;716.0512321174465;820.9425340226187;838.3586556284447;870.2385412763832;763.2825144364308;850.8893843800297;865.2688478235881;866.0689758509595;866.0949307973152;911.4576826788084;911.8221946720392;912.6121398405684;913.6391125505421;917.4311926605513;722.7940037089456;883.690708252113;906.9818603627923;908.4458480326995;921.8018126102853;683.2518392360357;683.5420268420171;685.6503183376464;686.9553479023848;690.4165979747106;14632.41470341185;14665.926670366687;14705.779413308808;14748.820094392422;14782.408703651841;13611.591652250449;13820.516281930084;13983.580492585137;14045.367958441895;14127.717445651133;12705.428255728515;12770.48918043277;12852.164609300458;12928.935355323258;13004.154729942618;4477.708948918343;4519.7740112994215;4593.655475839326;4642.396488456479;4728.101660684459;113592.86407135906;114070.02264762163;116997.83002169954;118614.22078668827;121980.39009804894;10589.788204235872;10644.89942278303;10652.733681658021;10715.410652414192;10741.78516429667;21271;21277.36167914965;21281.255156069772;21313.040913158944;21344.35966920995;7473.476856619985;7823.061232652118;7971.60141992898;7997.160298168725;8257.8348433031;4472;4526.592606665416;4529.977350113229;4569.109023740405;4666.673332866667;3483.5645544306963;3634.618365071682;3637.4907512948207;3640.5449318835144;3647.94528082079;565.7652074389082;685.5441131647498;694.2432748304373;694.5207806613522;695.2387136086079;464.93955785747636;534.2733881920585;610.1854024876839;614.7848253111465;615.9045347971072;7917.920820791718;8223.177682231848;9143.725688229364;9455.243580513543;9552.57013434397;540.3003110971223;585.8681796595818;617.7498113264136;644.7485480662546;657.7237560224621;4299;4428.778561071934;4437.156940181355;4480.529544397857;4483.860087693203;106114.46942765391;128815;168821.31178688302;169580.15209924118;173792.131039344;138706.30646846903;139883;142801;144649;150039;120565.19152212724;121726;122350.3882480582;125083;126654.10018849725;9657.951710241405;9765.951170244387;10261.538230779484;10311.639092631722;10362.948185259025;47798.52201477941;58109.70945145247;58858.41141588529;62052;62473.68763156155;92013.07986920045;93284.53357733168;93503.53248233715;93953.59069613824;97202.51398742961;12368.628941131781;12592.74814503723;13109.475620975054;13590.388432520758;13828.03203775726;15076.924615376853;15300.923495382453;15390.153541554873;15878.60303492422;15944.760828587348;13326.133801302884;14000.369983350978;14533.563993080224;14609.780853287422;14699.412023519368;13579.117357371739;14062;14287.357068931715;14734.336954836843;14867.92566037163;13819.447222111003;13974.650633734238;14000.299985000505;14003.229822359868;14013.929930350283;10774;11133.665990020312;11459.31244125355;11518.654440366803;12250.081243906565;10055.434567412278;11476.770464590494;11621.418929053345;11696.940204383704;11785.351805650771 14:31:26 INFO - PROCESS | 1651 | __end_tp_report 14:31:26 INFO - PROCESS | 1651 | __start_cc_report 14:31:26 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1400 14:31:26 INFO - PROCESS | 1651 | __end_cc_report 14:31:26 INFO - PROCESS | 1651 | __startTimestamp1471901486682__endTimestamp 14:31:26 INFO - PROCESS | 1651 | 14:31:26 INFO - PROCESS | 1651 | ------- Summary: start ------- 14:31:26 INFO - PROCESS | 1651 | Number of tests: 6 14:31:26 INFO - PROCESS | 1651 | 14:31:26 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5693.65 Median:5858.18 stddev:663.58 (11.3%) stddev-sans-first:620.72 14:31:26 INFO - PROCESS | 1651 | Values: 2634.9 3354.4 3355.6 3356.8 3368.0 5456.6 5525.8 5556.9 5629.7 5651.7 5538.6 5557.5 5600.9 5610.3 5653.6 5109.6 5134.1 5157.8 5181.4 5222.7 5213.7 5273.6 5283.4 5285.2 5287.2 5039.7 5185.0 5187.1 5223.1 5223.3 4596.0 5030.7 5037.6 5101.7 5111.4 5085.4 5136.7 5141.6 5144.7 5158.3 5343.8 5632.3 5636.2 5643.4 5670.2 5861.9 6079.8 6175.1 6190.4 6242.9 5168.7 6300.6 6311.2 6316.7 6320.1 5756.7 5767.0 5776.9 5781.4 5790.7 6206.5 6272.6 6331.2 6332.1 6363.3 6029.6 6095.1 6100.6 6113.8 6118.7 6154.9 6248.7 6249.8 6253.2 6263.8 5932.8 6057.7 6098.8 6109.2 6180.8 6228.6 6239.8 6247.2 6249.1 6258.5 4949.3 4953.2 4955.2 4960.6 4970.8 4332.9 4399.8 4404.9 4407.8 4440.5 5584.5 5636.0 5638.2 5685.8 5694.4 6231.5 6254.0 6281.1 6294.2 6309.1 5512.1 5609.3 5681.8 5683.8 5691.7 5331.8 5352.8 5356.0 5415.2 5438.9 6293.5 6321.9 6323.8 6350.4 6356.2 6300.2 6307.0 6321.6 6325.6 6336.6 6152.3 6248.0 6317.8 6329.3 6344.5 6136.8 6176.0 6187.4 6192.8 6221.9 6091.2 6263.5 6263.6 6265.1 6284.9 5839.4 5941.4 6001.7 6030.4 6103.1 6060.9 6067.6 6071.7 6087.8 6091.7 5822.1 5837.9 5858.2 5861.3 5873.5 5803.0 5904.1 5909.8 5935.1 6064.9 5792.6 5827.8 5863.8 5864.5 5864.6 14:31:26 INFO - PROCESS | 1651 | 14:31:26 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:65301.88 Median:370674.00 stddev:147212.98 (39.7%) stddev-sans-first:147545.46 14:31:26 INFO - PROCESS | 1651 | Values: 461.8 472.5 491.3 529.0 541.7 30630.5 39252.8 40284.0 40357.8 40423.0 42168.4 42431.8 42489.2 42572.6 42584.8 9639.3 9800.3 9807.0 9816.2 9821.8 9489.9 9568.8 9576.3 9596.4 9600.3 9543.9 9601.8 9604.8 9605.2 9614.7 9530.5 9579.4 9584.8 9587.9 9588.3 9632.0 9729.4 9730.5 9739.1 9771.2 39698.4 40024.0 40093.0 40125.4 40156.4 3570.9 3608.7 3618.6 3621.5 3842.8 25617.7 30598.4 31764.5 31950.7 32162.0 3200.2 3288.3 3289.4 3307.0 3429.8 368469.0 370188.0 371160.0 373062.0 374217.1 33892.3 34542.7 56493.7 56953.4 57003.7 34370.0 34610.8 34658.8 34730.7 34742.8 14705.9 14863.7 14870.6 14871.6 14891.9 12606.5 12666.0 12668.1 12693.7 12710.6 7686.5 7708.7 7771.0 7773.6 7797.3 3175.4 3226.4 3231.0 3236.9 3257.7 818.5 939.3 1036.8 1060.0 1066.7 29396.3 29852.4 30158.4 30545.9 30764.5 1048.5 1066.4 1099.0 1124.5 1142.6 14873.3 15195.4 15499.5 15905.9 15933.6 568670.0 691682.0 693666.0 694037.0 695397.0 57889.7 58169.0 58224.0 58254.4 58285.0 1213.2 1345.6 1349.5 1389.6 1396.9 29689.9 29833.7 30087.0 30229.4 30521.8 41393.0 49030.3 49049.8 49113.7 49287.8 556646.0 562362.0 562561.0 563028.0 563145.0 22546.3 24748.9 25152.4 25549.6 25581.0 44970.1 45036.5 45195.8 45397.1 45573.8 36996.0 37311.3 37707.6 38507.8 38573.6 36467.6 36576.8 36816.6 37380.0 37560.4 35156.6 35208.5 35265.8 35334.0 35452.8 31117.9 31544.5 33236.0 33505.0 33673.2 21155.6 24452.6 24541.5 25025.4 25217.7 14:31:26 INFO - PROCESS | 1651 | 14:31:26 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:37867.69 Median:15155.93 stddev:102410.62 (675.7%) stddev-sans-first:102659.16 14:31:26 INFO - PROCESS | 1651 | Values: 347.3 366.8 375.6 382.8 403.1 15801.6 16042.1 21477.2 21925.2 22208.9 20559.6 21261.6 21726.0 22123.6 22442.5 5168.7 6253.8 7390.1 7780.5 7883.4 4163.5 7007.7 7732.3 7732.5 7801.6 4910.0 7719.7 8113.1 8125.2 8147.6 6820.9 7384.0 8020.7 8095.4 8119.6 7713.2 7731.8 7788.9 7804.0 7811.4 29098.6 29288.7 29769.9 29905.1 29964.6 2237.7 2430.6 2580.8 2616.8 2679.9 16471.3 16559.7 17425.1 17592.0 17599.4 1921.4 1977.2 1979.8 1984.4 1990.7 140083.0 140112.9 142097.3 143022.3 148345.3 21336.9 21463.9 21564.4 21642.5 21764.6 35745.4 35763.6 35790.0 35805.5 35845.8 10776.5 11078.0 11218.0 11251.9 11456.9 9176.0 9196.8 9201.8 9336.0 9366.3 8400.9 8456.7 9214.7 9702.3 9896.9 2671.5 2979.6 3686.1 3747.7 3784.0 692.5 796.2 812.0 862.2 1017.5 18351.6 21464.4 21997.8 22031.6 22207.9 876.5 884.3 908.7 925.1 956.6 10291.9 10978.8 11773.7 11779.5 11782.1 588474.0 601842.0 614192.0 629071.0 629904.0 104161.5 124596.0 127089.4 128414.0 130750.0 935.7 961.5 987.5 992.1 992.7 16181.8 19435.6 19751.4 19769.0 19843.2 52451.0 52859.2 53405.0 53791.7 53968.7 78848.6 81624.6 82975.6 84826.0 85823.6 8024.8 8147.4 8288.0 8337.0 8473.0 12832.8 13224.6 13304.0 13408.5 13587.9 9338.3 10835.8 11289.1 11307.9 11569.9 9339.3 11156.4 11350.2 11614.9 11672.7 11422.8 11566.7 11721.1 11736.7 11870.9 8126.3 8276.2 8322.8 8330.3 8454.7 11052.9 11241.7 11592.5 11640.0 11697.2 14:31:26 INFO - PROCESS | 1651 | 14:31:26 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:5681.43 Median:4818.18 stddev:3182.44 (66.1%) stddev-sans-first:3175.52 14:31:26 INFO - PROCESS | 1651 | Values: 1455.2 1515.7 1644.4 1772.7 1821.6 8371.9 8904.8 8907.2 8923.8 8924.7 7795.3 7994.2 8454.7 8674.2 8677.1 2326.7 2349.9 2360.2 2361.1 2364.4 2340.1 2352.6 2387.1 2388.2 2395.8 2349.8 2373.0 2374.0 2385.1 2393.1 2337.1 2350.6 2354.9 2361.0 2363.1 2325.6 2347.6 2349.3 2353.6 2355.6 8741.6 8838.6 8865.6 8872.5 8928.4 5149.2 5313.6 5327.6 5336.0 5339.3 3569.6 3582.2 3642.1 3649.5 3655.1 1069.3 1075.9 1078.5 1089.8 1104.6 11494.9 11610.0 11612.3 11621.5 11621.8 4487.6 4629.1 4733.8 4737.6 4777.7 9859.2 9868.0 9871.2 9871.7 9891.7 5316.5 5328.7 5333.9 5346.1 5347.8 4360.4 4516.6 4725.0 4868.5 4901.0 3823.6 3870.9 3946.6 3984.8 4031.0 1294.1 1294.5 1303.1 1311.7 1315.6 881.7 921.8 927.3 937.5 979.0 5798.3 5902.7 6028.8 6114.6 6215.4 422.5 442.4 457.1 466.4 469.5 3252.1 4035.8 4037.2 4099.2 4156.3 10180.9 10507.6 10537.1 10671.0 10693.9 10416.7 10614.3 10615.2 10619.6 10627.3 7710.5 8022.0 8058.1 8111.3 8129.7 5950.4 6006.5 6107.6 6228.1 6250.9 9875.8 10065.2 10118.8 10137.0 10154.4 8774.5 9769.7 10272.3 10319.7 10365.6 6156.4 6904.7 7120.2 7485.7 7631.2 8120.2 8183.0 8450.7 8460.0 8464.0 6650.7 7429.5 7480.5 7549.5 7678.4 7334.2 7357.2 7389.3 7404.6 7521.7 6901.9 7057.2 7064.7 7065.8 7072.4 4599.8 4858.7 5030.9 5071.6 5115.4 5027.0 5032.4 5143.8 5165.7 5246.2 14:31:26 INFO - PROCESS | 1651 | 14:31:26 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4430.20 Median:4800.65 stddev:1399.70 (29.2%) stddev-sans-first:1368.26 14:31:26 INFO - PROCESS | 1651 | Values: 264.8 304.6 314.0 315.2 318.5 5322.7 5338.8 5343.8 5356.5 5360.7 4002.8 4744.8 5279.4 5295.7 5300.3 3839.2 4068.7 4077.0 4079.9 4098.7 3565.7 4105.0 4107.7 4108.2 4121.6 3927.4 4018.8 4037.4 4070.2 4096.1 3948.5 3996.0 4022.6 4026.4 4049.0 2791.5 3282.7 3368.2 3484.1 3521.3 4239.7 4910.5 5157.3 5177.5 5187.7 3900.0 4214.9 4235.7 4339.5 4348.5 5165.6 5232.5 5561.7 5568.0 5609.4 3556.0 3625.8 3850.0 3866.0 3873.9 5613.0 5683.9 5816.4 5900.0 5953.8 3707.3 3729.3 3739.8 3744.5 3745.8 3288.9 3342.6 3934.6 3941.8 3952.0 3888.4 4585.8 4619.6 4650.5 4683.2 5407.6 5645.2 5659.6 5715.8 5741.8 1084.4 1260.9 1325.7 1341.7 1349.6 767.6 801.2 809.5 822.6 824.2 3882.0 4372.7 4390.4 4446.2 4456.8 3842.6 4494.1 4494.4 4583.9 4775.6 3571.7 3723.5 4206.5 4234.7 4394.9 2504.6 2525.8 3038.0 3089.0 3102.9 4666.8 5862.9 6019.6 6050.6 6051.0 5198.0 5217.6 5675.4 5881.6 6004.0 5999.4 6009.7 6051.8 6065.5 6073.6 4977.8 5832.1 5839.4 5850.4 5874.8 5004.4 5181.4 5262.3 5747.9 5761.8 5113.9 5490.3 5690.2 5714.6 6059.7 3601.7 3844.0 3876.2 3881.0 3904.1 4857.5 5645.0 5873.5 5883.8 5894.3 5178.6 5393.1 5447.3 5594.1 5743.7 4303.7 4883.0 5630.1 5652.7 5667.6 4449.5 5491.8 5525.5 5527.6 5555.1 4947.1 5320.9 5487.4 5560.8 5613.4 4825.7 5143.1 5417.2 5538.6 5545.3 14:31:26 INFO - PROCESS | 1651 | 14:31:26 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:25925.57 Median:21297.15 stddev:42190.94 (198.1%) stddev-sans-first:42266.43 14:31:26 INFO - PROCESS | 1651 | Values: 595.3 736.9 778.6 798.1 805.6 12286.9 16439.6 16463.6 16465.5 16475.3 14633.8 14873.6 14898.4 14902.1 14999.6 689.9 716.1 820.9 838.4 870.2 763.3 850.9 865.3 866.1 866.1 911.5 911.8 912.6 913.6 917.4 722.8 883.7 907.0 908.4 921.8 683.3 683.5 685.7 687.0 690.4 14632.4 14665.9 14705.8 14748.8 14782.4 13611.6 13820.5 13983.6 14045.4 14127.7 12705.4 12770.5 12852.2 12928.9 13004.2 4477.7 4519.8 4593.7 4642.4 4728.1 113592.9 114070.0 116997.8 118614.2 121980.4 10589.8 10644.9 10652.7 10715.4 10741.8 21271.0 21277.4 21281.3 21313.0 21344.4 7473.5 7823.1 7971.6 7997.2 8257.8 4472.0 4526.6 4530.0 4569.1 4666.7 3483.6 3634.6 3637.5 3640.5 3647.9 565.8 685.5 694.2 694.5 695.2 464.9 534.3 610.2 614.8 615.9 7917.9 8223.2 9143.7 9455.2 9552.6 540.3 585.9 617.7 644.7 657.7 4299.0 4428.8 4437.2 4480.5 4483.9 106114.5 128815.0 168821.3 169580.2 173792.1 138706.3 139883.0 142801.0 144649.0 150039.0 120565.2 121726.0 122350.4 125083.0 126654.1 9658.0 9766.0 10261.5 10311.6 10362.9 47798.5 58109.7 58858.4 62052.0 62473.7 92013.1 93284.5 93503.5 93953.6 97202.5 12368.6 12592.7 13109.5 13590.4 13828.0 15076.9 15300.9 15390.2 15878.6 15944.8 13326.1 14000.4 14533.6 14609.8 14699.4 13579.1 14062.0 14287.4 14734.3 14867.9 13819.4 13974.7 14000.3 14003.2 14013.9 10774.0 11133.7 11459.3 11518.7 12250.1 10055.4 11476.8 11621.4 11696.9 11785.4 14:31:26 INFO - PROCESS | 1651 | -------- Summary: end -------- 14:31:26 INFO - PROCESS | 1651 | 14:31:27 INFO - TEST-INFO | 1651: exit 0 14:31:27 INFO - TEST-OK | dromaeo_css | took 1116648ms 14:31:27 INFO - TEST-START | kraken 14:31:27 INFO - operating with platform_type : mac_ 14:31:27 INFO - Initialising browser for kraken test... 14:31:27 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/tmp47WMMC/profile http://localhost:49276/getInfo.html) 14:31:29 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 14:31:29 INFO - PROCESS | 1662 | colorDepth:24 14:31:29 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 14:31:29 INFO - PROCESS | 1662 | __metrics 14:31:29 INFO - PROCESS | 1662 | 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" 14:31:29 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:31:30 INFO - TEST-INFO | 1662: exit 0 14:31:30 INFO - Browser initialized. 14:31:30 INFO - Running cycle 1/1 for kraken test... 14:31:30 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/T/tmp47WMMC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:31:42 INFO - PROCESS | 1663 | RSS: Main: 228929536 14:31:42 INFO - PROCESS | 1663 | 14:31:44 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 14:31:45 INFO - PROCESS | 1663 | RSS: Main: 294268928 14:31:45 INFO - PROCESS | 1663 | 14:31:48 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 14:31:48 INFO - PROCESS | 1663 | RSS: Main: 294858752 14:31:48 INFO - PROCESS | 1663 | 14:31:52 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 14:31:52 INFO - PROCESS | 1663 | RSS: Main: 379920384 14:31:52 INFO - PROCESS | 1663 | 14:31:54 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 14:31:55 INFO - PROCESS | 1663 | RSS: Main: 281559040 14:31:55 INFO - PROCESS | 1663 | 14:31:57 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:31:58 INFO - PROCESS | 1663 | RSS: Main: 286879744 14:31:58 INFO - PROCESS | 1663 | 14:32:01 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 14:32:01 INFO - PROCESS | 1663 | RSS: Main: 324784128 14:32:01 INFO - PROCESS | 1663 | 14:32:04 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 14:32:05 INFO - PROCESS | 1663 | RSS: Main: 324829184 14:32:05 INFO - PROCESS | 1663 | 14:32:07 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 14:32:08 INFO - PROCESS | 1663 | RSS: Main: 323788800 14:32:08 INFO - PROCESS | 1663 | 14:32:10 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:32:10 INFO - PROCESS | 1663 | RSS: Main: 299966464 14:32:10 INFO - PROCESS | 1663 | 14:32:12 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:32:13 INFO - PROCESS | 1663 | RSS: Main: 303714304 14:32:13 INFO - PROCESS | 1663 | 14:32:15 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:32:16 INFO - PROCESS | 1663 | RSS: Main: 312340480 14:32:16 INFO - PROCESS | 1663 | 14:32:19 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:32:19 INFO - PROCESS | 1663 | RSS: Main: 316149760 14:32:19 INFO - PROCESS | 1663 | 14:32:22 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:32:23 INFO - PROCESS | 1663 | RSS: Main: 317698048 14:32:23 INFO - PROCESS | 1663 | 14:32:25 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 14:32:25 INFO - PROCESS | 1663 | RSS: Main: 361246720 14:32:25 INFO - PROCESS | 1663 | 14:32:25 INFO - PROCESS | 1663 | __start_tp_report 14:32:25 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 14:32:25 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 14:32:25 INFO - PROCESS | 1663 | |i|pagename|runs| 14:32:25 INFO - PROCESS | 1663 | |0;ai-astar;97;114;107;114;113;114;116;114;112;113 14:32:25 INFO - PROCESS | 1663 | |1;audio-beat-detection;144;110;126;155;108;127;124;106;156;105 14:32:25 INFO - PROCESS | 1663 | |2;audio-dft;187;185;185;184;183;184;184;185;180;183 14:32:25 INFO - PROCESS | 1663 | |3;audio-fft;73;78;104;92;57;58;65;86;92;47 14:32:25 INFO - PROCESS | 1663 | |4;audio-oscillator;83;84;132;71;72;80;116;72;91;151 14:32:25 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;87;83;87;85;87;83;87;85;86;84 14:32:25 INFO - PROCESS | 1663 | |6;imaging-darkroom;135;125;93;94;101;94;93;93;98;92 14:32:25 INFO - PROCESS | 1663 | |7;imaging-desaturate;86;87;84;84;86;86;85;86;86;86 14:32:25 INFO - PROCESS | 1663 | |8;json-parse-financial;53;54;52;53;50;50;67;80;83;83 14:32:25 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;64;67;66;75;79;72;72;70;69;70 14:32:25 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;89;88;92;101;87;88;89;88;90;120 14:32:25 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;140;138;137;137;148;147;150;136;152;136 14:32:25 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;168;166;164;176;171;230;204;165;168;167 14:32:25 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;67;68;68;67;67;66;67;67;66;66 14:32:25 INFO - PROCESS | 1663 | __end_tp_report 14:32:25 INFO - PROCESS | 1663 | __start_cc_report 14:32:25 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,2094 14:32:25 INFO - PROCESS | 1663 | __end_cc_report 14:32:25 INFO - PROCESS | 1663 | __startTimestamp1471901545468__endTimestamp 14:32:25 INFO - PROCESS | 1663 | 14:32:25 INFO - PROCESS | 1663 | ------- Summary: start ------- 14:32:25 INFO - PROCESS | 1663 | Number of tests: 14 14:32:25 INFO - PROCESS | 1663 | 14:32:25 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:111.40 Median:114.00 stddev:5.58 (4.9%) stddev-sans-first:2.50 14:32:25 INFO - PROCESS | 1663 | Values: 97.0 114.0 107.0 114.0 113.0 114.0 116.0 114.0 112.0 113.0 14:32:25 INFO - PROCESS | 1663 | 14:32:25 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:126.10 Median:126.50 stddev:19.69 (15.6%) stddev-sans-first:19.80 14:32:25 INFO - PROCESS | 1663 | Values: 144.0 110.0 126.0 155.0 108.0 127.0 124.0 106.0 156.0 105.0 14:32:25 INFO - PROCESS | 1663 | 14:32:25 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.50 stddev:1.83 (1.0%) stddev-sans-first:1.58 14:32:25 INFO - PROCESS | 1663 | Values: 187.0 185.0 185.0 184.0 183.0 184.0 184.0 185.0 180.0 183.0 14:32:25 INFO - PROCESS | 1663 | 14:32:25 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:75.20 Median:75.50 stddev:18.41 (24.4%) stddev-sans-first:19.51 14:32:25 INFO - PROCESS | 1663 | Values: 73.0 78.0 104.0 92.0 57.0 58.0 65.0 86.0 92.0 47.0 14:32:25 INFO - PROCESS | 1663 | 14:32:25 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:76.00 stddev:28.06 (36.9%) stddev-sans-first:29.41 14:32:25 INFO - PROCESS | 1663 | Values: 83.0 84.0 132.0 71.0 72.0 80.0 116.0 72.0 91.0 151.0 14:32:25 INFO - PROCESS | 1663 | 14:32:25 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:85.40 Median:86.50 stddev:1.65 (1.9%) stddev-sans-first:1.64 14:32:25 INFO - PROCESS | 1663 | Values: 87.0 83.0 87.0 85.0 87.0 83.0 87.0 85.0 86.0 84.0 14:32:25 INFO - PROCESS | 1663 | 14:32:25 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:101.80 Median:93.00 stddev:15.30 (16.4%) stddev-sans-first:10.49 14:32:25 INFO - PROCESS | 1663 | Values: 135.0 125.0 93.0 94.0 101.0 94.0 93.0 93.0 98.0 92.0 14:32:25 INFO - PROCESS | 1663 | 14:32:25 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:86.00 stddev:0.97 (1.1%) stddev-sans-first:1.01 14:32:25 INFO - PROCESS | 1663 | Values: 86.0 87.0 84.0 84.0 86.0 86.0 85.0 86.0 86.0 86.0 14:32:25 INFO - PROCESS | 1663 | 14:32:25 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:60.50 stddev:14.31 (23.6%) stddev-sans-first:14.76 14:32:25 INFO - PROCESS | 1663 | Values: 53.0 54.0 52.0 53.0 50.0 50.0 67.0 80.0 83.0 83.0 14:32:25 INFO - PROCESS | 1663 | 14:32:25 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:71.00 stddev:4.40 (6.2%) stddev-sans-first:4.01 14:32:25 INFO - PROCESS | 1663 | Values: 64.0 67.0 66.0 75.0 79.0 72.0 72.0 70.0 69.0 70.0 14:32:25 INFO - PROCESS | 1663 | 14:32:25 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:93.20 Median:88.50 stddev:10.25 (11.6%) stddev-sans-first:10.76 14:32:25 INFO - PROCESS | 1663 | Values: 89.0 88.0 92.0 101.0 87.0 88.0 89.0 88.0 90.0 120.0 14:32:25 INFO - PROCESS | 1663 | 14:32:25 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:142.10 Median:143.50 stddev:6.38 (4.4%) stddev-sans-first:6.73 14:32:25 INFO - PROCESS | 1663 | Values: 140.0 138.0 137.0 137.0 148.0 147.0 150.0 136.0 152.0 136.0 14:32:25 INFO - PROCESS | 1663 | 14:32:25 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.90 Median:169.50 stddev:21.76 (12.8%) stddev-sans-first:22.79 14:32:25 INFO - PROCESS | 1663 | Values: 168.0 166.0 164.0 176.0 171.0 230.0 204.0 165.0 168.0 167.0 14:32:25 INFO - PROCESS | 1663 | 14:32:25 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 14:32:25 INFO - PROCESS | 1663 | Values: 67.0 68.0 68.0 67.0 67.0 66.0 67.0 67.0 66.0 66.0 14:32:25 INFO - PROCESS | 1663 | -------- Summary: end -------- 14:32:25 INFO - PROCESS | 1663 | 14:32:26 INFO - TEST-INFO | 1663: exit 0 14:32:26 INFO - TEST-OK | kraken | took 59030ms 14:32:26 INFO - SUITE-END | took 1175s 14:32:26 INFO - Completed test suite (00:19:35) 14:32:26 INFO - javascript benchmark 14:32:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2634.8550829704363, 3354.4297469430194, 3355.6141043779944, 3356.7985920844735, 3367.966320336796, 5456.61803673743, 5525.778968841241, 5556.9444305556935, 5629.7185140743, 5651.717414129293, 5538.6399884007515, 5557.472040156189, 5600.943990560093, 5610.326760788711, 5653.575981801371, 5109.616778741591, 5134.050200712862, 5157.7936882524655, 5181.404138524081, 5222.686638801684, 5213.713245771481, 5273.551748101416, 5283.445238249986, 5285.180796976456, 5287.206918962167, 5039.697618142924, 5185.040767458032, 5187.092258854723, 5223.112070947948, 5223.320968274119, 4595.954040459586, 5030.723310217936, 5037.5718063964605, 5101.668391554537, 5111.412187598399, 5085.415177254589, 5136.743162841843, 5141.562967147797, 5144.717040562768, 5158.277841102249, 5343.786248550054, 5632.295963004624, 5636.15457681347, 5643.435656434365, 5670.177824215466, 5861.912071318934, 6079.787207447718, 6175.104609831549, 6190.350013248589, 6242.875142497124, 5168.715720635363, 6300.590461620026, 6311.2426508819235, 6316.684165791692, 6320.146780184662, 5756.740946657411, 5767.0, 5776.942230577724, 5781.364049954502, 5790.652560846363, 6206.503479721611, 6272.5922815016875, 6331.176946996861, 6332.081848131995, 6363.331850155667, 6029.60807547508, 6095.05526643371, 6100.572959892765, 6113.816585502442, 6118.724657390339, 6154.876902462015, 6248.656323902229, 6249.812505624838, 6253.218347706536, 6263.780767673201, 5932.762689492458, 6057.666828324396, 6098.847528811726, 6109.236345456818, 6180.783672571439, 6228.5951413158, 6239.750409983641, 6247.219097612799, 6249.0626406039455, 6258.468030217391, 4949.30709700635, 4953.157963146274, 4955.231939049453, 4960.578350840146, 4970.826021089245, 4332.870013899588, 4399.780010999437, 4404.867853964386, 4407.801648925806, 4440.533743956838, 5584.497395234448, 5636.013697602903, 5638.182463542763, 5685.829425117253, 5694.402087780806, 6231.470325022424, 6254.0, 6281.089242059968, 6294.181756371734, 6309.053641953652, 5512.145617429305, 5609.298837645294, 5681.801136960269, 5683.8010669626365, 5691.68695721731, 5331.840044798662, 5352.785888564414, 5356.0, 5415.241866138744, 5438.864028399322, 6293.465055470337, 6321.873562528724, 6323.841903952438, 6350.396712312508, 6356.237251529661, 6300.21247344082, 6307.0, 6321.620702757849, 6325.620462772248, 6336.58812177207, 6152.292486364126, 6248.0, 6317.778877739257, 6329.303776584664, 6344.524160688059, 6136.846578835565, 6176.0, 6187.381261873957, 6192.845178870384, 6221.875562488634, 6091.177691011657, 6263.467605253422, 6263.592866463665, 6265.091561723616, 6284.937150628435, 5839.416058394127, 5941.435563621449, 6001.7299221536005, 6030.396960303934, 6103.115048318058, 6060.909036373495, 6067.575269731076, 6071.726772295346, 6087.847803804941, 6091.695415229309, 5822.126680997715, 5837.94162058374, 5858.179854820243, 5861.32594751609, 5873.530117590668, 5803.042497987784, 5904.143899134516, 5909.763609455574, 5935.109733540004, 6064.909026364697, 5792.565557583114, 5827.766889324549, 5863.794767183128, 5864.501517371071, 5864.618799778001], "value": 5648.707300118676, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [461.7921935129191, 472.5439950447818, 491.2998976458548, 528.9761960711768, 541.6722882655993, 30630.54054189189, 39252.80373598132, 40283.992900177545, 40357.79821100898, 40423.0, 42168.36747448791, 42431.78784106083, 42489.150216995644, 42572.57427425725, 42584.787076064575, 9639.325247232697, 9800.26498012652, 9806.950965245163, 9816.165625921769, 9821.754456138582, 9489.90510094897, 9568.80862382752, 9576.281778866578, 9596.376235544667, 9600.279979001569, 9543.904560954406, 9601.75995600112, 9604.759881002996, 9605.231581473501, 9614.71155865325, 9530.475823829687, 9579.377340472882, 9584.808303833885, 9587.856182157204, 9588.280878934107, 9632.036796320383, 9729.367591106555, 9730.513474326326, 9739.074787895139, 9771.169450596708, 39698.404523932164, 40024.0, 40093.0, 40125.398119028236, 40156.397654035216, 3570.8571657133684, 3608.729345299113, 3618.6200448952745, 3621.4567814827988, 3842.8078596070086, 25617.743822561722, 30598.388032239454, 31764.523532147035, 31950.680493195236, 32162.03513894587, 3200.247941733691, 3288.3423315337027, 3289.3914625794305, 3306.966930330714, 3429.8285085745615, 368469.0, 370187.9999999973, 371160.0, 373062.0, 374217.12891435367, 33892.32215355679, 34542.65457345445, 56493.71753141208, 56953.430465695645, 57003.714981424826, 34370.0, 34610.82694586511, 34658.82670586631, 34730.65269347325, 34742.82628586841, 14705.926470367795, 14863.70272594542, 14870.628234294229, 14871.553853384416, 14891.925540372229, 12606.49574017029, 12666.0, 12668.113232073667, 12693.730626937233, 12710.555130570385, 7686.461947663722, 7708.691652333844, 7770.961145194238, 7773.611319434119, 7797.298243158029, 3175.412548678502, 3226.3708576827294, 3230.951535726966, 3236.8705251790134, 3257.674232576723, 818.5170749257848, 939.2861425316809, 1036.7610705207355, 1060.0194819791661, 1066.6746642274181, 29396.265093372836, 29852.402951941272, 30158.396832063674, 30545.93089241866, 30764.53853192204, 1048.4705223862054, 1066.424130969268, 1099.0328510910347, 1124.4771181400688, 1142.6457798082622, 14873.256337183098, 15195.392184312725, 15499.457518986781, 15905.920470397574, 15933.601659958595, 568670.0, 691682.0, 693666.0, 694037.0, 695397.0, 57889.71055144697, 58169.0, 58224.0, 58254.417455825744, 58285.0, 1213.2417239225483, 1345.6299517632533, 1349.4602159136227, 1389.5692335376066, 1396.8952328575601, 29689.851550742973, 29833.701662983094, 30087.0, 30229.421051578924, 30521.847390762905, 41393.0, 49030.26454603255, 49049.75475122601, 49113.65067938388, 49287.767805803705, 556646.0, 562362.0, 562561.0, 563028.0, 563145.0, 22546.323610291718, 24748.87625561861, 25152.371190719645, 25549.61675574905, 25580.976760930098, 44970.100597987206, 45036.54963450324, 45195.774021131, 45397.09205815799, 45573.77213113913, 36996.0, 37311.253774924895, 37707.62292377041, 38507.80746096252, 38573.614263857, 36467.63532364643, 36576.81711591425, 36816.63183368132, 37380.0, 37560.43659345167, 35156.64843351636, 35208.471872921415, 35265.82367088148, 35334.0, 35452.822735886155, 31117.910873119334, 31544.526832097996, 33236.0, 33504.99485015454, 33673.15817104592, 21155.576888462452, 24452.633210501503, 24541.509169816145, 25025.368277406138, 25217.747822522273], "value": 18266.295954113913, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.3019231344996, 366.7909291703728, 375.6243756243756, 382.82964080983953, 403.11516221892936, 15801.604959875995, 16042.117683527402, 21477.174440172603, 21925.23261685841, 22208.88895555524, 20559.588808223827, 21261.57476850462, 21726.0, 22123.557528849455, 22442.5214091816, 5168.741562921858, 6253.781117660883, 7390.113186417638, 7780.494267872598, 7883.448158628869, 4163.458750362449, 7007.684654190548, 7732.304092631662, 7732.497387669811, 7801.595712771699, 4910.0, 7719.72980945667, 8113.066997295298, 8125.187481251886, 8147.592620368988, 6820.942753873158, 7384.0, 8020.719274825382, 8095.392845536549, 8119.553424561646, 7713.228677132298, 7731.806704832424, 7788.883166752503, 7803.960980195119, 7811.414143939171, 29098.563521547192, 29288.707112929023, 29769.851150744325, 29905.102846914626, 29964.550531742043, 2237.6867238586447, 2430.6232533957264, 2580.83224590401, 2616.842989420622, 2679.9196024119306, 16471.34114635425, 16559.68164456977, 17425.1287435629, 17592.0, 17599.38402155931, 1921.4427815933363, 1977.1992343101067, 1979.831714304286, 1984.4145976936838, 1990.6556984266426, 140083.0, 140112.89830652447, 142097.2895135528, 143022.28488857593, 148345.258273709, 21336.89331553332, 21463.892680536497, 21564.35306940794, 21642.458938526346, 21764.564708705737, 35745.35310409682, 35763.64236357655, 35790.0, 35805.46291805625, 35845.82077089598, 10776.461176941122, 11078.0, 11218.0, 11251.94374028141, 11456.885431145749, 9176.0, 9196.770080748034, 9201.769955751026, 9336.0, 9366.29752768545, 8400.907881975305, 8456.704015359555, 9214.663873738271, 9702.320837541305, 9896.901030989598, 2671.452352267819, 2979.6275465566805, 3686.078480379905, 3747.7376583638884, 3784.0, 692.4840993459904, 796.2435686098114, 812.0174588747682, 862.2326129744532, 1017.5370206555999, 18351.632967340847, 21464.356069317946, 21997.780022199895, 22031.559368812534, 22207.888960555418, 876.5266755951715, 884.3323290915317, 908.681961313535, 925.0980294213089, 956.5791051937125, 10291.897081029243, 10978.780424391467, 11773.705657358463, 11779.469923853447, 11782.116341274439, 588474.0, 601842.0, 614192.0, 629071.0, 629904.0, 104161.47919260507, 124596.0, 127089.36455317664, 128414.0, 130750.0, 935.6725146198776, 961.5144352102144, 987.511181964932, 992.1417973452911, 992.6823416506649, 16181.838181618034, 19435.61128777388, 19751.40745777629, 19769.011549422183, 19843.206271749546, 52451.0, 52859.207111894124, 53405.0, 53791.731041344545, 53968.65078372915, 78848.60575697085, 81624.5918770426, 82975.585122074, 84826.0, 85823.57088214518, 8024.799380015546, 8147.388945828968, 8288.0, 8337.0, 8473.0, 12832.807507887203, 13224.603261902159, 13304.004399339789, 13408.463661453432, 13587.86412135866, 9338.252939764938, 10835.837462437912, 11289.096872250364, 11307.943460282646, 11569.942150289195, 9339.346245762732, 11156.386398747822, 11350.205485616258, 11614.88385116138, 11672.70818229551, 11422.828657569977, 11566.710832229262, 11721.12091593117, 11736.706582335168, 11870.940645296718, 8126.349892008507, 8276.172382761675, 8322.750317490485, 8330.250277475056, 8454.704085356983, 11052.944735276273, 11241.66275011751, 11592.536298547964, 11640.0, 11697.23967942081], "value": 11135.458094855154, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1455.1850963460463, 1515.7271691095602, 1644.4244514419947, 1772.6631939931403, 1821.5628249220192, 8371.87442188367, 8904.777380565489, 8907.24288435483, 8923.821523569524, 8924.732258032262, 7795.259450352208, 7994.200579942003, 8454.704085357014, 8674.221784534155, 8677.132286771319, 2326.7091613548305, 2349.9177528786495, 2360.173939121311, 2361.055577768898, 2364.432536191319, 2340.0990618611786, 2352.635341522067, 2387.128698025217, 2388.22382725614, 2395.8442701224367, 2349.835511514195, 2372.9881350593223, 2373.9881300593474, 2385.0936644075314, 2393.1384701507445, 2337.135259953811, 2350.647402889572, 2354.9058037678474, 2361.0319768894756, 2363.102021231921, 2325.5813953488364, 2347.624380099176, 2349.259983105316, 2353.646952957053, 2355.5759963206615, 8741.606627701769, 8838.55807209637, 8865.556722163867, 8872.46765194084, 8928.419652722552, 5149.176131818891, 5313.628046036779, 5327.600429967729, 5336.0, 5339.279197308352, 3569.5538057742783, 3582.2119133790525, 3642.1440961374055, 3649.5255616769914, 3655.0862284428895, 1069.251523933242, 1075.854759607451, 1078.5470102556867, 1089.7983872983443, 1104.6244276945877, 11494.885051149466, 11609.955104040677, 11612.303261804318, 11621.53513859453, 11621.76756464866, 4487.618552423015, 4629.097326021393, 4733.834315798999, 4737.644676649265, 4777.689450185727, 9859.161971232526, 9867.950660246654, 9871.210303175872, 9871.654492092743, 9891.653792117242, 5316.46835316473, 5328.706921119376, 5333.893322133536, 5346.144616861361, 5347.786088556414, 4360.389545463638, 4516.570925762047, 4725.0, 4868.537488938545, 4901.044296362175, 3823.617638236154, 3870.8838734838, 3946.6053394660303, 3984.780837053932, 4031.0, 1294.087668193921, 1294.4757722441277, 1303.0519373536624, 1311.6851955530603, 1315.6184706435026, 881.7046289493092, 921.7972046149837, 927.2816007808735, 937.4656445825814, 978.9804203916025, 5798.304203495608, 5902.704864756831, 6028.849278767978, 6114.602550834182, 6215.409536094064, 422.4824589877376, 442.38066706611, 457.07442429081374, 466.44493053266507, 469.4648101164675, 3252.1381833814057, 4035.8183881725395, 4037.172379662221, 4099.200655872136, 4156.314208155621, 10180.949095254477, 10507.579696812041, 10537.10434613051, 10671.0, 10693.9465302673, 10416.739581510372, 10614.25700200994, 10615.150787936947, 10619.628313009007, 10627.309224900357, 7710.460267781202, 8021.959890200512, 8058.11360750317, 8111.269985701315, 8129.715459958873, 5950.434708702666, 6006.549508786946, 6107.5724699272405, 6228.065790131516, 6250.906236406367, 9875.753106172404, 10065.24510661718, 10118.797624047626, 10137.036981486746, 10154.44150571696, 8774.517401542977, 9769.706908792748, 10272.33229840058, 10319.742006449898, 10365.585376584851, 6156.445919867234, 6904.723811047502, 7120.216776154515, 7485.663145158372, 7631.236876312324, 8120.228578285053, 8183.0, 8450.746477605682, 8460.027096883938, 8464.0, 6650.733970641314, 7429.517081389692, 7480.476366654282, 7549.5463974207505, 7678.385729141543, 7334.229905859808, 7357.153927298215, 7389.298016688406, 7404.629768511661, 7521.699132034657, 6901.861962760616, 7057.153141623038, 7064.717411303696, 7065.788026359218, 7072.3634872861685, 4599.770011499345, 4858.663867436483, 5030.899382012412, 5071.644984851173, 5115.386153661436, 5026.974865125797, 5032.370953630796, 5143.819966301311, 5165.715885626327, 5246.213068039825], "value": 4504.218464969416, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [264.76618955666595, 304.5659934593205, 313.9968600313996, 315.21825871837825, 318.5333486442361, 5322.707251101193, 5338.759755810988, 5343.812966546172, 5356.4911333423315, 5360.731963401824, 4002.8170561762954, 4744.837514808876, 5279.392869819972, 5295.655782374143, 5300.257963885059, 3839.178204020043, 4068.6948478864056, 4076.9592304077023, 4079.9184016319805, 4098.733582317155, 3565.6969157621634, 4104.994276402271, 4107.67138628909, 4108.198901214264, 4121.5672354402805, 3927.3519869221545, 4018.799060046986, 4037.4347591337237, 4070.1656160487178, 4096.078382363974, 3948.4866967294356, 3996.002997751686, 4022.5776293489057, 4026.4095682205657, 4049.0, 2791.469620772067, 3282.7373810095137, 3368.191634007845, 3484.0767196692896, 3521.3485505181366, 4239.724417912826, 4910.533499317559, 5157.329547158845, 5177.48225177483, 5187.688738675692, 3899.980500097481, 4214.904124927541, 4235.703500754948, 4339.457567804025, 4348.5216626171095, 5165.612579056586, 5232.529072383466, 5561.746378368659, 5568.0, 5609.353919952023, 3555.986543834995, 3625.782453052825, 3849.9797553648305, 3866.0, 3873.941890871611, 5612.971935140339, 5683.943160568383, 5816.418358164192, 5899.970500147515, 5953.821385358447, 3707.3141468828353, 3729.291434627412, 3739.8317075731657, 3744.513213282256, 3745.831437585315, 3288.901332960015, 3342.6490218526706, 3934.626210510054, 3941.7832019238645, 3952.0, 3888.3972984187494, 4585.79363928624, 4619.620895238954, 4650.488591207803, 4683.157031734252, 5407.621056630534, 5645.1532270159805, 5659.603827732101, 5715.771369145271, 5741.770329186786, 1084.4329943232112, 1260.87391260875, 1325.7348530293787, 1341.7182391697852, 1349.5748839115647, 767.6353731977266, 801.1973060613619, 809.4900212865974, 822.6051495282178, 824.1593574553922, 3882.0395700171234, 4372.731907746782, 4390.429244198233, 4446.177457170369, 4456.844010459618, 3842.615738426135, 4494.146217152132, 4494.359568749258, 4583.931241031387, 4775.594074503637, 3571.7321200910037, 3723.515942927402, 4206.497134205143, 4234.6823988201, 4394.890127746768, 2504.5742223821994, 2525.76237643557, 3038.0, 3088.98455507721, 3102.860371283298, 4666.766661666903, 5862.941370586324, 6019.578629495981, 6050.606710563799, 6050.969745151246, 5198.0, 5217.58259339252, 5675.3757086720425, 5881.5588830837005, 6004.0, 5999.400059994053, 6009.716307803007, 6051.7925499485345, 6065.4541091302, 6073.635581865014, 4977.776000079933, 5832.066869300891, 5839.357670656309, 5850.444207800252, 5874.796951143321, 5004.39947206323, 5181.404138524118, 5262.263283140287, 5747.8563035924435, 5761.798337058183, 5113.897722045613, 5490.286262785812, 5690.174924635988, 5714.599978001666, 6059.697015149313, 3601.675849173587, 3844.000559854402, 3876.244132394156, 3880.9805950970062, 3904.121572646132, 4857.465678775261, 5644.971775141098, 5873.500752436091, 5883.794067207627, 5894.263217097863, 5178.585713143015, 5393.1461684484275, 5447.291852059207, 5594.0769772987005, 5743.655380677173, 4303.720258183208, 4882.95117048825, 5630.127330263816, 5652.7173641318595, 5667.631603945731, 4449.488308844395, 5491.752871120889, 5525.502704756591, 5527.585431092764, 5555.083496193806, 4947.109520286383, 5320.946790532045, 5487.368952570346, 5560.777568897199, 5613.438656134354, 4825.710457372569, 5143.099957507496, 5417.160340147283, 5538.612297139322, 5545.251391062155], "value": 3984.0830622000017, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.2826843653397, 736.9093741262927, 778.58345785005, 798.1180795221284, 805.6334367862623, 12286.938565307171, 16439.58901027475, 16463.588410289747, 16465.506034818944, 16475.340986360563, 14633.780493292583, 14873.553793386189, 14898.40406383746, 14902.105873647588, 14999.625009374744, 689.9034135221073, 716.0512321174465, 820.9425340226187, 838.3586556284447, 870.2385412763832, 763.2825144364308, 850.8893843800297, 865.2688478235881, 866.0689758509595, 866.0949307973152, 911.4576826788084, 911.8221946720392, 912.6121398405684, 913.6391125505421, 917.4311926605513, 722.7940037089456, 883.690708252113, 906.9818603627923, 908.4458480326995, 921.8018126102853, 683.2518392360357, 683.5420268420171, 685.6503183376464, 686.9553479023848, 690.4165979747106, 14632.41470341185, 14665.926670366687, 14705.779413308808, 14748.820094392422, 14782.408703651841, 13611.591652250449, 13820.516281930084, 13983.580492585137, 14045.367958441895, 14127.717445651133, 12705.428255728515, 12770.48918043277, 12852.164609300458, 12928.935355323258, 13004.154729942618, 4477.708948918343, 4519.7740112994215, 4593.655475839326, 4642.396488456479, 4728.101660684459, 113592.86407135906, 114070.02264762163, 116997.83002169954, 118614.22078668827, 121980.39009804894, 10589.788204235872, 10644.89942278303, 10652.733681658021, 10715.410652414192, 10741.78516429667, 21271.0, 21277.36167914965, 21281.255156069772, 21313.040913158944, 21344.35966920995, 7473.476856619985, 7823.061232652118, 7971.60141992898, 7997.160298168725, 8257.8348433031, 4472.0, 4526.592606665416, 4529.977350113229, 4569.109023740405, 4666.673332866667, 3483.5645544306963, 3634.618365071682, 3637.4907512948207, 3640.5449318835144, 3647.94528082079, 565.7652074389082, 685.5441131647498, 694.2432748304373, 694.5207806613522, 695.2387136086079, 464.93955785747636, 534.2733881920585, 610.1854024876839, 614.7848253111465, 615.9045347971072, 7917.920820791718, 8223.177682231848, 9143.725688229364, 9455.243580513543, 9552.57013434397, 540.3003110971223, 585.8681796595818, 617.7498113264136, 644.7485480662546, 657.7237560224621, 4299.0, 4428.778561071934, 4437.156940181355, 4480.529544397857, 4483.860087693203, 106114.46942765391, 128815.0, 168821.31178688302, 169580.15209924118, 173792.131039344, 138706.30646846903, 139883.0, 142801.0, 144649.0, 150039.0, 120565.19152212724, 121726.0, 122350.3882480582, 125083.0, 126654.10018849725, 9657.951710241405, 9765.951170244387, 10261.538230779484, 10311.639092631722, 10362.948185259025, 47798.52201477941, 58109.70945145247, 58858.41141588529, 62052.0, 62473.68763156155, 92013.07986920045, 93284.53357733168, 93503.53248233715, 93953.59069613824, 97202.51398742961, 12368.628941131781, 12592.74814503723, 13109.475620975054, 13590.388432520758, 13828.03203775726, 15076.924615376853, 15300.923495382453, 15390.153541554873, 15878.60303492422, 15944.760828587348, 13326.133801302884, 14000.369983350978, 14533.563993080224, 14609.780853287422, 14699.412023519368, 13579.117357371739, 14062.0, 14287.357068931715, 14734.336954836843, 14867.92566037163, 13819.447222111003, 13974.650633734238, 14000.299985000505, 14003.229822359868, 14013.929930350283, 10774.0, 11133.665990020312, 11459.31244125355, 11518.654440366803, 12250.081243906565, 10055.434567412278, 11476.770464590494, 11621.418929053345, 11696.940204383704, 11785.351805650771], "value": 7948.151026907284, "unit": "score"}], "name": "dromaeo_css", "value": 7397.668125480338, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 114.0, 107.0, 114.0, 113.0, 114.0, 116.0, 114.0, 112.0, 113.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 110.0, 126.0, 155.0, 108.0, 127.0, 124.0, 106.0, 156.0, 105.0], "value": 126.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 185.0, 185.0, 184.0, 183.0, 184.0, 184.0, 185.0, 180.0, 183.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 78.0, 104.0, 92.0, 57.0, 58.0, 65.0, 86.0, 92.0, 47.0], "value": 75.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 132.0, 71.0, 72.0, 80.0, 116.0, 72.0, 91.0, 151.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 87.0, 85.0, 87.0, 83.0, 87.0, 85.0, 86.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 125.0, 93.0, 94.0, 101.0, 94.0, 93.0, 93.0, 98.0, 92.0], "value": 101.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 84.0, 84.0, 86.0, 86.0, 85.0, 86.0, 86.0, 86.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 52.0, 53.0, 50.0, 50.0, 67.0, 80.0, 83.0, 83.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 66.0, 75.0, 79.0, 72.0, 72.0, 70.0, 69.0, 70.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 92.0, 101.0, 87.0, 88.0, 89.0, 88.0, 90.0, 120.0], "value": 93.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 138.0, 137.0, 137.0, 148.0, 147.0, 150.0, 136.0, 152.0, 136.0], "value": 142.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 166.0, 164.0, 176.0, 171.0, 230.0, 204.0, 165.0, 168.0, 167.0], "value": 177.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 67.0, 67.0, 66.0, 67.0, 67.0, 66.0, 66.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1477.7, "alertThreshold": 2.0}]} 14:32:26 INFO - Return code: 0 14:32:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:32:26 INFO - # TBPL SUCCESS # 14:32:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:32:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:32:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:32:26 INFO - 2016-08-22 14:32:26.794 screenresolution[1667:9768] starting screenresolution argv=screenresolution get 14:32:26 INFO - 2016-08-22 14:32:26.797 screenresolution[1667:9768] Display 0: 1600x1200x32@60 14:32:26 INFO - 2016-08-22 14:32:26.803 screenresolution[1668:9771] starting screenresolution argv=screenresolution list 14:32:26 INFO - Available Modes on Display 0 14:32:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:32:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:32:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:32:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:32:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:32:27 INFO - Intel Iris: 14:32:27 INFO - Chipset Model: Intel Iris 14:32:27 INFO - Type: GPU 14:32:27 INFO - Bus: Built-In 14:32:27 INFO - VRAM (Dynamic, Max): 1536 MB 14:32:27 INFO - Vendor: Intel (0x8086) 14:32:27 INFO - Device ID: 0x0a2e 14:32:27 INFO - Revision ID: 0x0009 14:32:27 INFO - Displays: 14:32:27 INFO - Display: 14:32:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:32:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:32:27 INFO - Display Serial Number: 1600x1200 60 14:32:27 INFO - Main Display: Yes 14:32:27 INFO - Mirror: Off 14:32:27 INFO - Online: Yes 14:32:27 INFO - Rotation: Supported 14:32:27 INFO - Return code: 0 14:32:27 INFO - Running post-action listener: _resource_record_post_action 14:32:27 INFO - [mozharness: 2016-08-22 21:32:27.036797Z] Finished run-tests step (success) 14:32:27 INFO - Running post-run listener: _resource_record_post_run 14:32:27 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 37262336; Write bytes: 706077696; Read time: 238; Write time: 1944 14:32:27 INFO - TinderboxPrint: CPU usage
53.7% 14:32:27 INFO - TinderboxPrint: I/O read bytes / time
37,262,336 / 238 14:32:27 INFO - TinderboxPrint: I/O write bytes / time
706,077,696 / 1,944 14:32:27 INFO - TinderboxPrint: CPU idle
2,241.2 (46.3%) 14:32:27 INFO - TinderboxPrint: CPU system
970.0 (20.0%) 14:32:27 INFO - TinderboxPrint: CPU user
1,630.5 (33.7%) 14:32:27 INFO - TinderboxPrint: Swap in / out
443,682,816 / 0 14:32:27 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 404029952; Write bytes: 396830720; Read time: 29907; Write time: 797 14:32:27 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 35116032; Write bytes: 295087104; Read time: 216; Write time: 1106 14:32:27 INFO - Running post-run listener: _upload_blobber_files 14:32:27 INFO - Blob upload gear active. 14:32:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:32:27 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 14:32:27 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:32:27 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:32:27 INFO - (blobuploader) - INFO - Open directory for files ... 14:32:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:32:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:32:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:32:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:32:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:32:28 INFO - (blobuploader) - INFO - Done attempting. 14:32:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:32:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:32:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:32:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:32:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:32:29 INFO - (blobuploader) - INFO - Done attempting. 14:32:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:32:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:32:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:32:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:32:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:32:32 INFO - (blobuploader) - INFO - Done attempting. 14:32:32 INFO - (blobuploader) - INFO - Iteration through files over. 14:32:32 INFO - Return code: 0 14:32:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:32:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:32:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ab3eb359fbd4b0976d5f13ad5ff91efb92046a151cbdec36c4910732d3ae32240f97f0f64375469a7ca391a2d35a261adec41c0d74c485c7cf49558f300eaa2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/78391841b0a2d4f102764fec023f951277b39c26b2adef30d479f5a3dce55890b34730f71952519c83ce006c6ae6975dabd826ed7b8b2b55ab58451ebffad103", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4d242b061c540ba6cef0e931ef6d40bbdb901bcc600beb6beec03642486d062cd73e92078804c0392274042d166c81ece56cb0ba63323df3779fe57727b59f7"} 14:32:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:32:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:32:32 INFO - Contents: 14:32:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ab3eb359fbd4b0976d5f13ad5ff91efb92046a151cbdec36c4910732d3ae32240f97f0f64375469a7ca391a2d35a261adec41c0d74c485c7cf49558f300eaa2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/78391841b0a2d4f102764fec023f951277b39c26b2adef30d479f5a3dce55890b34730f71952519c83ce006c6ae6975dabd826ed7b8b2b55ab58451ebffad103", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4d242b061c540ba6cef0e931ef6d40bbdb901bcc600beb6beec03642486d062cd73e92078804c0392274042d166c81ece56cb0ba63323df3779fe57727b59f7"} 14:32:32 INFO - Running post-run listener: copy_logs_to_upload_dir 14:32:32 INFO - Copying logs to upload dir... 14:32:32 INFO - mkdir: /builds/slave/test/build/upload/logs 14:32:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.554269 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-22 14:32:32.558006) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 14:32:32.561943) ========= 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.MCZZinzfHY/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.iHuYDpgUbW/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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/Fx-Team/sha512/8ab3eb359fbd4b0976d5f13ad5ff91efb92046a151cbdec36c4910732d3ae32240f97f0f64375469a7ca391a2d35a261adec41c0d74c485c7cf49558f300eaa2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/78391841b0a2d4f102764fec023f951277b39c26b2adef30d479f5a3dce55890b34730f71952519c83ce006c6ae6975dabd826ed7b8b2b55ab58451ebffad103", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4d242b061c540ba6cef0e931ef6d40bbdb901bcc600beb6beec03642486d062cd73e92078804c0392274042d166c81ece56cb0ba63323df3779fe57727b59f7"} build_url:https://queue.taskcluster.net/v1/task/e5zgcQh1SM2Tm2ykKlQT5Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011052 build_url: 'https://queue.taskcluster.net/v1/task/e5zgcQh1SM2Tm2ykKlQT5Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ab3eb359fbd4b0976d5f13ad5ff91efb92046a151cbdec36c4910732d3ae32240f97f0f64375469a7ca391a2d35a261adec41c0d74c485c7cf49558f300eaa2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/78391841b0a2d4f102764fec023f951277b39c26b2adef30d479f5a3dce55890b34730f71952519c83ce006c6ae6975dabd826ed7b8b2b55ab58451ebffad103", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4d242b061c540ba6cef0e931ef6d40bbdb901bcc600beb6beec03642486d062cd73e92078804c0392274042d166c81ece56cb0ba63323df3779fe57727b59f7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 14:32:32.595168) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 14:32:32.595485) ========= 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.MCZZinzfHY/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.iHuYDpgUbW/Listeners TMPDIR=/var/folders/jp/6dm4jt356msd6dqb5shhcwxm00000w/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.005310 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 14:32:32.644379) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 14:32:32.644702) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 14:32:32.645035) ========= ========= Total master_lag: 0.18 =========