builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0322 starttime: 1471882518.87 results: success (0) buildid: 20160822064441 builduid: 0bb9dc8637cb452b8470a0a23584a29a revision: 194fe275b4e60ded2af6b25173eec421f0dba8ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 09:15:18.875064) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 09:15:18.875702) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 09:15:18.876171) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 09:15:18.909478) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:15:18.910053) ========= 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.bkAtUQgLyl/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.eAgWcA4mGg/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 09:15:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.6M=0.001s 2016-08-22 09:15:19 (18.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119504 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:15:19.053798) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:15:19.054109) ========= 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.bkAtUQgLyl/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.eAgWcA4mGg/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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.025786 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:15:19.103188) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 09:15:19.103541) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 194fe275b4e60ded2af6b25173eec421f0dba8ad --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 194fe275b4e60ded2af6b25173eec421f0dba8ad --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bkAtUQgLyl/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.eAgWcA4mGg/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 09:15:19,184 truncating revision to first 12 chars 2016-08-22 09:15:19,185 Setting DEBUG logging. 2016-08-22 09:15:19,185 attempt 1/10 2016-08-22 09:15:19,185 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/194fe275b4e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 09:15:20,062 unpacking tar archive at: mozilla-central-194fe275b4e6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.131712 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 09:15:20.257935) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 09:15:20.258273) ========= script_repo_revision: 194fe275b4e60ded2af6b25173eec421f0dba8ad ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 09:15:20.258672) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 09:15:20.258941) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 09:15:20.277659) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-22 09:15:20.278028) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bkAtUQgLyl/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.eAgWcA4mGg/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 09:15:20 INFO - MultiFileLogger online at 20160822 09:15:20 in /builds/slave/test 09:15:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:15:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:15:20 INFO - {'append_to_log': False, 09:15:20 INFO - 'base_work_dir': '/builds/slave/test', 09:15:20 INFO - 'blob_upload_branch': 'Firefox', 09:15:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:15:20 INFO - 'branch': 'Firefox', 09:15:20 INFO - 'buildbot_json_path': 'buildprops.json', 09:15:20 INFO - 'config_files': ('talos/mac_config.py',), 09:15:20 INFO - 'default_actions': ('clobber', 09:15:20 INFO - 'read-buildbot-config', 09:15:20 INFO - 'download-and-extract', 09:15:20 INFO - 'populate-webroot', 09:15:20 INFO - 'create-virtualenv', 09:15:20 INFO - 'install', 09:15:20 INFO - 'run-tests'), 09:15:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:15:20 INFO - 'download_minidump_stackwalk': True, 09:15:20 INFO - 'download_symbols': 'ondemand', 09:15:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:15:20 INFO - 'tooltool.py': '/tools/tooltool.py', 09:15:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:15:20 INFO - '/tools/misc-python/virtualenv.py')}, 09:15:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:15:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:15:20 INFO - 'installer_path': 'installer.exe', 09:15:20 INFO - 'log_level': 'info', 09:15:20 INFO - 'log_name': 'talos', 09:15:20 INFO - 'log_to_console': True, 09:15:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:15:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:15:20 INFO - 'opt_config_files': (), 09:15:20 INFO - 'pip_index': False, 09:15:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:15:20 INFO - 'cmd': ('bash', 09:15:20 INFO - '-c', 09:15:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:15:20 INFO - 'enabled': True, 09:15:20 INFO - 'halt_on_failure': False, 09:15:20 INFO - 'name': 'check_screen_resolution'},), 09:15:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:15:20 INFO - 'cmd': ('bash', 09:15:20 INFO - '-c', 09:15:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:15:20 INFO - 'enabled': True, 09:15:20 INFO - 'halt_on_failure': False, 09:15:20 INFO - 'name': 'check_screen_resolution'},), 09:15:20 INFO - 'run_cmd_checks_enabled': True, 09:15:20 INFO - 'sps_profile': False, 09:15:20 INFO - 'sps_profile_interval': 0, 09:15:20 INFO - 'suite': 'dromaeojs', 09:15:20 INFO - 'system_bits': '32', 09:15:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:15:20 INFO - 'title': 't-yosemite-r7-0322', 09:15:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:15:20 INFO - 'use_talos_json': True, 09:15:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:15:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:15:20 INFO - 'work_dir': 'build'} 09:15:20 INFO - [mozharness: 2016-08-22 16:15:20.471487Z] Running clobber step. 09:15:20 INFO - Running pre-action listener: _resource_record_pre_action 09:15:20 INFO - Running main action method: clobber 09:15:20 INFO - rmtree: /builds/slave/test/build 09:15:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:15:22 INFO - Running post-action listener: _resource_record_post_action 09:15:22 INFO - [mozharness: 2016-08-22 16:15:22.494175Z] Finished clobber step (success) 09:15:22 INFO - [mozharness: 2016-08-22 16:15:22.494301Z] Running read-buildbot-config step. 09:15:22 INFO - Running pre-action listener: _resource_record_pre_action 09:15:22 INFO - Running main action method: read_buildbot_config 09:15:22 INFO - Using buildbot properties: 09:15:22 INFO - { 09:15:22 INFO - "project": "", 09:15:22 INFO - "product": "firefox", 09:15:22 INFO - "script_repo_revision": "production", 09:15:22 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:15:22 INFO - "repository": "", 09:15:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:15:22 INFO - "buildid": "20160822064441", 09:15:22 INFO - "stage_platform": "macosx64", 09:15:22 INFO - "basedir": "/builds/slave/test", 09:15:22 INFO - "nightly_build": "True", 09:15:22 INFO - "buildnumber": 28, 09:15:22 INFO - "slavename": "t-yosemite-r7-0322", 09:15:22 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 09:15:22 INFO - "platform": "yosemite_r7", 09:15:22 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:15:22 INFO - "branch": "mozilla-central", 09:15:22 INFO - "repo_path": "mozilla-central", 09:15:22 INFO - "revision": "194fe275b4e60ded2af6b25173eec421f0dba8ad", 09:15:22 INFO - "pgo_build": "False", 09:15:22 INFO - "builduid": "0bb9dc8637cb452b8470a0a23584a29a", 09:15:22 INFO - "slavebuilddir": "test" 09:15:22 INFO - } 09:15:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/JINZnX9qTQuZ9Lu-BOmtJg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 09:15:22 INFO - Running post-action listener: _resource_record_post_action 09:15:22 INFO - [mozharness: 2016-08-22 16:15:22.497863Z] Finished read-buildbot-config step (success) 09:15:22 INFO - [mozharness: 2016-08-22 16:15:22.497990Z] Running download-and-extract step. 09:15:22 INFO - Running pre-action listener: _resource_record_pre_action 09:15:22 INFO - Running main action method: download_and_extract 09:15:22 INFO - mkdir: /builds/slave/test/build/tests 09:15: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')]} 09:15:22 INFO - trying https://queue.taskcluster.net/v1/task/JINZnX9qTQuZ9Lu-BOmtJg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 09:15:22 INFO - Downloading https://queue.taskcluster.net/v1/task/JINZnX9qTQuZ9Lu-BOmtJg/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 09:15:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JINZnX9qTQuZ9Lu-BOmtJg/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 09:15:23 INFO - Downloaded 1199 bytes. 09:15:23 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 09:15:23 INFO - Using the following test package requirements: 09:15:23 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 09:15:23 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:15:23 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 09:15:23 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:15:23 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 09:15:23 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:15:23 INFO - u'jsshell-mac.zip'], 09:15:23 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:15:23 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 09:15:23 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 09:15:23 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:15:23 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 09:15:23 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:15:23 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 09:15:23 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:15:23 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 09:15:23 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:15:23 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 09:15:23 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:15: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')]} 09:15:23 INFO - trying https://queue.taskcluster.net/v1/task/JINZnX9qTQuZ9Lu-BOmtJg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 09:15:23 INFO - Downloading https://queue.taskcluster.net/v1/task/JINZnX9qTQuZ9Lu-BOmtJg/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 09:15:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JINZnX9qTQuZ9Lu-BOmtJg/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 09:15:24 INFO - Downloaded 16352538 bytes. 09:15: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 09:15: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 09:15: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')]} 09:15:31 INFO - trying https://queue.taskcluster.net/v1/task/JINZnX9qTQuZ9Lu-BOmtJg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 09:15:31 INFO - Downloading https://queue.taskcluster.net/v1/task/JINZnX9qTQuZ9Lu-BOmtJg/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 09:15:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JINZnX9qTQuZ9Lu-BOmtJg/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 09:15:32 INFO - Downloaded 16352538 bytes. 09:15: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 09:15: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')]} 09:15:38 INFO - trying https://queue.taskcluster.net/v1/task/JINZnX9qTQuZ9Lu-BOmtJg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 09:15:38 INFO - Downloading https://queue.taskcluster.net/v1/task/JINZnX9qTQuZ9Lu-BOmtJg/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 09:15:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JINZnX9qTQuZ9Lu-BOmtJg/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 09:15:40 INFO - Downloaded 14413981 bytes. 09:15:40 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 09:15: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')]} 09:15:40 INFO - trying https://queue.taskcluster.net/v1/task/JINZnX9qTQuZ9Lu-BOmtJg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 09:15:40 INFO - Downloading https://queue.taskcluster.net/v1/task/JINZnX9qTQuZ9Lu-BOmtJg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 09:15:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JINZnX9qTQuZ9Lu-BOmtJg/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 09:15:43 INFO - Downloaded 111642312 bytes. 09:15:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JINZnX9qTQuZ9Lu-BOmtJg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 09:15:43 INFO - mkdir: /builds/slave/test/properties 09:15:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:15:43 INFO - Writing to file /builds/slave/test/properties/build_url 09:15:43 INFO - Contents: 09:15:43 INFO - build_url:https://queue.taskcluster.net/v1/task/JINZnX9qTQuZ9Lu-BOmtJg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 09:15:44 INFO - Running post-action listener: _resource_record_post_action 09:15:44 INFO - Running post-action listener: set_extra_try_arguments 09:15:44 INFO - [mozharness: 2016-08-22 16:15:44.132824Z] Finished download-and-extract step (success) 09:15:44 INFO - [mozharness: 2016-08-22 16:15:44.132953Z] Running populate-webroot step. 09:15:44 INFO - Running pre-action listener: _resource_record_pre_action 09:15:44 INFO - Running main action method: populate_webroot 09:15:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:15:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:15:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:15:44 INFO - '--tppagecycles', 09:15:44 INFO - '7'], 09:15:44 INFO - 'tests': ['tsvgm']}}, 09:15:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:15:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:15:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:15:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:15:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:15:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:15:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:44 INFO - 'talos_options': ['--disable-e10s'], 09:15:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:15:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:15:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:44 INFO - 'talos_options': ['--disable-e10s'], 09:15:44 INFO - 'tests': ['damp', 'tps']}, 09:15:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:44 INFO - 'tests': ['damp', 'tps']}, 09:15:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:15:44 INFO - 'tests': ['dromaeo_dom']}, 09:15:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:15:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:15:44 INFO - 'tests': ['basic_compositor_video']}, 09:15:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:15:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:15:44 INFO - 'tests': ['a11yr', 09:15:44 INFO - 'ts_paint', 09:15:44 INFO - 'tpaint', 09:15:44 INFO - 'sessionrestore', 09:15:44 INFO - 'sessionrestore_no_auto_restore', 09:15:44 INFO - 'tabpaint']}, 09:15:44 INFO - 'other-e10s': {'tests': ['a11yr', 09:15:44 INFO - 'ts_paint', 09:15:44 INFO - 'tpaint', 09:15:44 INFO - 'sessionrestore', 09:15:44 INFO - 'sessionrestore_no_auto_restore', 09:15:44 INFO - 'tabpaint']}, 09:15:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:15:44 INFO - 'ts_paint', 09:15:44 INFO - 'tpaint', 09:15:44 INFO - 'sessionrestore', 09:15:44 INFO - 'sessionrestore_no_auto_restore', 09:15:44 INFO - 'tabpaint']}, 09:15:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:15:44 INFO - 'ts_paint', 09:15:44 INFO - 'tpaint', 09:15:44 INFO - 'sessionrestore', 09:15:44 INFO - 'sessionrestore_no_auto_restore', 09:15:44 INFO - 'tabpaint']}, 09:15:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:15:44 INFO - 'tests': ['a11yr', 09:15:44 INFO - 'ts_paint', 09:15:44 INFO - 'tpaint', 09:15:44 INFO - 'sessionrestore', 09:15:44 INFO - 'sessionrestore_no_auto_restore', 09:15:44 INFO - 'tabpaint']}, 09:15:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:15:44 INFO - 'tests': ['a11yr', 09:15:44 INFO - 'ts_paint', 09:15:44 INFO - 'tpaint', 09:15:44 INFO - 'sessionrestore', 09:15:44 INFO - 'sessionrestore_no_auto_restore', 09:15:44 INFO - 'tabpaint']}, 09:15:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:15:44 INFO - 'tests': ['tsvgx', 09:15:44 INFO - 'tsvgr_opacity', 09:15:44 INFO - 'tart', 09:15:44 INFO - 'tscrollx', 09:15:44 INFO - 'cart']}, 09:15:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:15:44 INFO - 'tsvgr_opacity', 09:15:44 INFO - 'tart', 09:15:44 INFO - 'tscrollx', 09:15:44 INFO - 'cart']}, 09:15:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:44 INFO - 'talos_options': ['--disable-e10s'], 09:15:44 INFO - 'tests': ['tp5o']}, 09:15:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:44 INFO - 'tests': ['tp5o']}, 09:15:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:44 INFO - 'talos_options': ['--disable-e10s', 09:15:44 INFO - '--xperf_path', 09:15:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:15:44 INFO - 'tests': ['tp5n']}, 09:15:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:44 INFO - 'talos_options': ['--xperf_path', 09:15:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:15:44 INFO - 'tests': ['tp5n']}}, 09:15:44 INFO - 'talos.zip': {'path': '', 09:15:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:15:44 INFO - Running post-action listener: _resource_record_post_action 09:15:44 INFO - [mozharness: 2016-08-22 16:15:44.151426Z] Finished populate-webroot step (success) 09:15:44 INFO - [mozharness: 2016-08-22 16:15:44.151567Z] Running create-virtualenv step. 09:15:44 INFO - Running pre-action listener: _resource_record_pre_action 09:15:44 INFO - Running main action method: create_virtualenv 09:15:44 INFO - Creating virtualenv /builds/slave/test/build/venv 09:15:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:15:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:15:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:15:44 INFO - Using real prefix '/tools/python27' 09:15:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:15:45 INFO - Installing distribute.............................................................................................................................................................................................done. 09:15:47 INFO - Installing pip.................done. 09:15:47 INFO - Return code: 0 09:15:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:15: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')]} 09:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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')]} 09:15:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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 0x104beda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c82618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe6148af40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b51d30>, '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 0x1048b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b49b20>, '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.bkAtUQgLyl/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.eAgWcA4mGg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 09:15: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 09:15: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 09:15:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bkAtUQgLyl/Render', 09:15:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:47 INFO - 'HOME': '/Users/cltbld', 09:15:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:47 INFO - 'LOGNAME': 'cltbld', 09:15:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:47 INFO - 'MOZ_NO_REMOTE': '1', 09:15:47 INFO - 'NO_EM_RESTART': '1', 09:15:47 INFO - 'PAGER': '/bin/cat', 09:15:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:47 INFO - 'PWD': '/builds/slave/test', 09:15:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:47 INFO - 'SHELL': '/bin/bash', 09:15:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eAgWcA4mGg/Listeners', 09:15:47 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 09:15:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:47 INFO - 'USER': 'cltbld', 09:15:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:47 INFO - 'XPC_FLAGS': '0x0', 09:15:47 INFO - 'XPC_SERVICE_NAME': '0', 09:15:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:15:48 INFO - Cleaning up... 09:15:48 INFO - Return code: 0 09:15:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104beda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c82618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe6148af40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b51d30>, '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 0x1048b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b49b20>, '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.bkAtUQgLyl/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.eAgWcA4mGg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 09:15:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:15:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:15:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bkAtUQgLyl/Render', 09:15:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:48 INFO - 'HOME': '/Users/cltbld', 09:15:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:48 INFO - 'LOGNAME': 'cltbld', 09:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:48 INFO - 'MOZ_NO_REMOTE': '1', 09:15:48 INFO - 'NO_EM_RESTART': '1', 09:15:48 INFO - 'PAGER': '/bin/cat', 09:15:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:48 INFO - 'PWD': '/builds/slave/test', 09:15:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:48 INFO - 'SHELL': '/bin/bash', 09:15:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eAgWcA4mGg/Listeners', 09:15:48 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 09:15:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:48 INFO - 'USER': 'cltbld', 09:15:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:48 INFO - 'XPC_FLAGS': '0x0', 09:15:48 INFO - 'XPC_SERVICE_NAME': '0', 09:15:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:48 INFO - Downloading/unpacking psutil>=3.1.1 09:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:15:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:15:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:15:51 INFO - Installing collected packages: psutil 09:15:51 INFO - Running setup.py install for psutil 09:15:51 INFO - building 'psutil._psutil_osx' extension 09:15: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 09:15: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 09:15: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 09:15:52 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:15:52 INFO - building 'psutil._psutil_posix' extension 09:15:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:15:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:15:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:15:52 INFO - ^ 09:15:52 INFO - 1 warning generated. 09:15: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 09:15:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:15:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:15:52 INFO - Successfully installed psutil 09:15:52 INFO - Cleaning up... 09:15:52 INFO - Return code: 0 09:15:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:15: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')]} 09:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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')]} 09:15:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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 0x104beda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c82618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe6148af40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b51d30>, '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 0x1048b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b49b20>, '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.bkAtUQgLyl/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.eAgWcA4mGg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 09:15: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 09:15: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 09:15:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bkAtUQgLyl/Render', 09:15:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:52 INFO - 'HOME': '/Users/cltbld', 09:15:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:52 INFO - 'LOGNAME': 'cltbld', 09:15:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:52 INFO - 'MOZ_NO_REMOTE': '1', 09:15:52 INFO - 'NO_EM_RESTART': '1', 09:15:52 INFO - 'PAGER': '/bin/cat', 09:15:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:52 INFO - 'PWD': '/builds/slave/test', 09:15:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:52 INFO - 'SHELL': '/bin/bash', 09:15:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eAgWcA4mGg/Listeners', 09:15:52 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 09:15:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:52 INFO - 'USER': 'cltbld', 09:15:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:52 INFO - 'XPC_FLAGS': '0x0', 09:15:52 INFO - 'XPC_SERVICE_NAME': '0', 09:15:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:15: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 09:15: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 09:15: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 09:15: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 09:15: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 09:15: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 09:15:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:15:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:15:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:15:55 INFO - Installing collected packages: mozsystemmonitor 09:15:55 INFO - Running setup.py install for mozsystemmonitor 09:15:55 INFO - Successfully installed mozsystemmonitor 09:15:55 INFO - Cleaning up... 09:15:55 INFO - Return code: 0 09:15:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:15: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')]} 09:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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')]} 09:15:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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 0x104beda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c82618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe6148af40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b51d30>, '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 0x1048b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b49b20>, '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.bkAtUQgLyl/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.eAgWcA4mGg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 09:15: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 09:15: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 09:15:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bkAtUQgLyl/Render', 09:15:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:55 INFO - 'HOME': '/Users/cltbld', 09:15:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:55 INFO - 'LOGNAME': 'cltbld', 09:15:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:55 INFO - 'MOZ_NO_REMOTE': '1', 09:15:55 INFO - 'NO_EM_RESTART': '1', 09:15:55 INFO - 'PAGER': '/bin/cat', 09:15:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:55 INFO - 'PWD': '/builds/slave/test', 09:15:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:55 INFO - 'SHELL': '/bin/bash', 09:15:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eAgWcA4mGg/Listeners', 09:15:55 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 09:15:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:55 INFO - 'USER': 'cltbld', 09:15:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:55 INFO - 'XPC_FLAGS': '0x0', 09:15:55 INFO - 'XPC_SERVICE_NAME': '0', 09:15:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:55 INFO - Downloading/unpacking jsonschema==2.5.1 09:15: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 09:15: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 09:15: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 09:15: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 09:15: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 09:15: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 09:15:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:15:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:15: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 09:15: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 09:15: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 09:15: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 09:15: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 09:15: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 09:15:58 INFO - Downloading functools32-3.2.3-2.tar.gz 09:15:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:15:58 INFO - warning: no files found matching '*.txt' 09:15:58 INFO - no previously-included directories found matching 'build' 09:15:58 INFO - no previously-included directories found matching 'dist' 09:15:58 INFO - no previously-included directories found matching '.git*' 09:15:58 INFO - Installing collected packages: jsonschema, functools32 09:15:58 INFO - Running setup.py install for functools32 09:15:58 INFO - warning: no files found matching '*.txt' 09:15:58 INFO - no previously-included directories found matching 'build' 09:15:58 INFO - no previously-included directories found matching 'dist' 09:15:58 INFO - no previously-included directories found matching '.git*' 09:15:59 INFO - Successfully installed jsonschema functools32 09:15:59 INFO - Cleaning up... 09:15:59 INFO - Return code: 0 09:15:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:15: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')]} 09:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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')]} 09:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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 0x104beda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c82618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe6148af40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b51d30>, '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 0x1048b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b49b20>, '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.bkAtUQgLyl/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.eAgWcA4mGg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 09:15: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 09:15: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 09:15:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bkAtUQgLyl/Render', 09:15:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:59 INFO - 'HOME': '/Users/cltbld', 09:15:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:59 INFO - 'LOGNAME': 'cltbld', 09:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:59 INFO - 'MOZ_NO_REMOTE': '1', 09:15:59 INFO - 'NO_EM_RESTART': '1', 09:15:59 INFO - 'PAGER': '/bin/cat', 09:15:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:59 INFO - 'PWD': '/builds/slave/test', 09:15:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:59 INFO - 'SHELL': '/bin/bash', 09:15:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eAgWcA4mGg/Listeners', 09:15:59 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 09:15:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:59 INFO - 'USER': 'cltbld', 09:15:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:59 INFO - 'XPC_FLAGS': '0x0', 09:15:59 INFO - 'XPC_SERVICE_NAME': '0', 09:15:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:15:59 INFO - Cleaning up... 09:15:59 INFO - Return code: 0 09:15:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:15: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')]} 09:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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')]} 09:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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 0x104beda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c82618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe6148af40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b51d30>, '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 0x1048b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b49b20>, '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.bkAtUQgLyl/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.eAgWcA4mGg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 09:15: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 09:15: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 09:15:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bkAtUQgLyl/Render', 09:15:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:15:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:15:59 INFO - 'HOME': '/Users/cltbld', 09:15:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:15:59 INFO - 'LOGNAME': 'cltbld', 09:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:59 INFO - 'MOZ_NO_REMOTE': '1', 09:15:59 INFO - 'NO_EM_RESTART': '1', 09:15:59 INFO - 'PAGER': '/bin/cat', 09:15:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:59 INFO - 'PWD': '/builds/slave/test', 09:15:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:15:59 INFO - 'SHELL': '/bin/bash', 09:15:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eAgWcA4mGg/Listeners', 09:15:59 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 09:15:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:15:59 INFO - 'USER': 'cltbld', 09:15:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:15:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:59 INFO - 'XPC_FLAGS': '0x0', 09:15:59 INFO - 'XPC_SERVICE_NAME': '0', 09:15:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:15:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:59 INFO - Downloading/unpacking blobuploader==1.2.4 09:15:59 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 09:15:59 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 09:15:59 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 09:15:59 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 09:15:59 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 09:15:59 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 09:16:02 INFO - Downloading blobuploader-1.2.4.tar.gz 09:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:16:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:16: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 09:16: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 09:16: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 09:16: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 09:16: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 09:16: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 09:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:16:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:16: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 09:16: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 09:16: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 09:16: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 09:16: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 09:16: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 09:16:03 INFO - Downloading docopt-0.6.1.tar.gz 09:16:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:16:03 INFO - Installing collected packages: blobuploader, requests, docopt 09:16:03 INFO - Running setup.py install for blobuploader 09:16:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:16:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:16:03 INFO - Running setup.py install for requests 09:16:03 INFO - Running setup.py install for docopt 09:16:04 INFO - Successfully installed blobuploader requests docopt 09:16:04 INFO - Cleaning up... 09:16:04 INFO - Return code: 0 09:16:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16: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')]} 09:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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')]} 09:16:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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 0x104beda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c82618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe6148af40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b51d30>, '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 0x1048b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b49b20>, '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.bkAtUQgLyl/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.eAgWcA4mGg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 09:16: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 09:16: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 09:16:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bkAtUQgLyl/Render', 09:16:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:04 INFO - 'HOME': '/Users/cltbld', 09:16:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:04 INFO - 'LOGNAME': 'cltbld', 09:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:04 INFO - 'MOZ_NO_REMOTE': '1', 09:16:04 INFO - 'NO_EM_RESTART': '1', 09:16:04 INFO - 'PAGER': '/bin/cat', 09:16:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:04 INFO - 'PWD': '/builds/slave/test', 09:16:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:04 INFO - 'SHELL': '/bin/bash', 09:16:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eAgWcA4mGg/Listeners', 09:16:04 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 09:16:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:04 INFO - 'USER': 'cltbld', 09:16:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:04 INFO - 'XPC_FLAGS': '0x0', 09:16:04 INFO - 'XPC_SERVICE_NAME': '0', 09:16:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:16:04 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-bqqz9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:16:04 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-LQQaPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:16:04 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-ofM4of-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:16:04 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-FHcpV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:16:04 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-2Cik0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:16:05 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-hZyxAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:16:05 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-brjEF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:16:05 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-PPI2nG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:16:05 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-6K9aXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:16:05 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-2ZjC1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:16:05 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-JvEJiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:16:05 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-NsY_l_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:16:05 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-vlErnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:16:05 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-rPg3yJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:05 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-WTiuLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:16:06 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-kyjTA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:16:06 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-drepQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:16:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:16:06 INFO - Running setup.py install for manifestparser 09:16:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:16:06 INFO - Running setup.py install for mozcrash 09:16:06 INFO - Running setup.py install for mozdebug 09:16:06 INFO - Running setup.py install for mozdevice 09:16:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:16:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:16:06 INFO - Running setup.py install for mozfile 09:16:06 INFO - Running setup.py install for mozhttpd 09:16:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:16:07 INFO - Running setup.py install for mozinfo 09:16:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:16:07 INFO - Running setup.py install for mozInstall 09:16:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:16:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:16:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:16:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:16:07 INFO - Running setup.py install for mozleak 09:16:07 INFO - Running setup.py install for mozlog 09:16:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:16:07 INFO - Running setup.py install for moznetwork 09:16:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:16:07 INFO - Running setup.py install for mozprocess 09:16:08 INFO - Running setup.py install for mozprofile 09:16:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:16:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:16:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:16:08 INFO - Running setup.py install for mozrunner 09:16:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:16:08 INFO - Running setup.py install for mozscreenshot 09:16:08 INFO - Running setup.py install for moztest 09:16:08 INFO - Running setup.py install for mozversion 09:16:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:16:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:16:08 INFO - Cleaning up... 09:16:08 INFO - Return code: 0 09:16:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:08 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')]} 09:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:08 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')]} 09:16:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:08 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 0x104beda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c82618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe6148af40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b51d30>, '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 0x1048b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b49b20>, '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.bkAtUQgLyl/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.eAgWcA4mGg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 09:16:08 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 09:16:08 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 09:16:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bkAtUQgLyl/Render', 09:16:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:08 INFO - 'HOME': '/Users/cltbld', 09:16:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:08 INFO - 'LOGNAME': 'cltbld', 09:16:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:08 INFO - 'MOZ_NO_REMOTE': '1', 09:16:08 INFO - 'NO_EM_RESTART': '1', 09:16:08 INFO - 'PAGER': '/bin/cat', 09:16:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:08 INFO - 'PWD': '/builds/slave/test', 09:16:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:08 INFO - 'SHELL': '/bin/bash', 09:16:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eAgWcA4mGg/Listeners', 09:16:08 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 09:16:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:08 INFO - 'USER': 'cltbld', 09:16:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:08 INFO - 'XPC_FLAGS': '0x0', 09:16:08 INFO - 'XPC_SERVICE_NAME': '0', 09:16:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:16:09 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-r_dBv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:16: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)) 09:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:16:09 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-1Tpyes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:16: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)) 09:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:16:09 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-p8jRhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:16: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)) 09:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:16:09 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-_wQCaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:16:09 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)) 09:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:16:09 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-OS9NNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:16:09 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)) 09:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:16:09 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-MZ7x26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:16:09 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)) 09:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:16:09 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-DoteOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:16:09 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)) 09:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:16:09 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-EyFwSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:16:09 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)) 09:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:16:09 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-dy1cXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:16: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)) 09:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:16:10 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-_fpKbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:16: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)) 09:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:16:10 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-AogPuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:16: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)) 09:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:16:10 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-fdGS9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:16: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)) 09:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:16:10 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-PT3w61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:16:10 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)) 09:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:16:10 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-Y8PhaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:16:10 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)) 09:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:10 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-sG5ggX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:10 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)) 09:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:16:10 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-KSYtGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:16:10 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)) 09:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:16:10 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-mAjDMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:16:10 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)) 09:16:10 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)) 09:16:10 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)) 09:16:10 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)) 09:16:10 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)) 09:16:10 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)) 09:16:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:16:10 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 09:16:10 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 09:16:10 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 09:16:10 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 09:16:10 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 09:16:10 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 09:16:13 INFO - Downloading blessings-1.6.tar.gz 09:16:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:16:13 INFO - Installing collected packages: blessings 09:16:13 INFO - Running setup.py install for blessings 09:16:13 INFO - Successfully installed blessings 09:16:13 INFO - Cleaning up... 09:16:13 INFO - Return code: 0 09:16:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:16:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:16:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:16:14 INFO - Reading from file tmpfile_stdout 09:16:14 INFO - Current package versions: 09:16:14 INFO - blessings == 1.6 09:16:14 INFO - blobuploader == 1.2.4 09:16:14 INFO - docopt == 0.6.1 09:16:14 INFO - functools32 == 3.2.3-2 09:16:14 INFO - jsonschema == 2.5.1 09:16:14 INFO - manifestparser == 1.1 09:16:14 INFO - mozInstall == 1.12 09:16:14 INFO - mozcrash == 0.17 09:16:14 INFO - mozdebug == 0.1 09:16:14 INFO - mozdevice == 0.48 09:16:14 INFO - mozfile == 1.2 09:16:14 INFO - mozhttpd == 0.7 09:16:14 INFO - mozinfo == 0.9 09:16:14 INFO - mozleak == 0.1 09:16:14 INFO - mozlog == 3.3 09:16:14 INFO - moznetwork == 0.27 09:16:14 INFO - mozprocess == 0.23 09:16:14 INFO - mozprofile == 0.28 09:16:14 INFO - mozrunner == 6.12 09:16:14 INFO - mozscreenshot == 0.1 09:16:14 INFO - mozsystemmonitor == 0.3 09:16:14 INFO - moztest == 0.7 09:16:14 INFO - mozversion == 1.4 09:16:14 INFO - psutil == 3.1.1 09:16:14 INFO - requests == 1.2.3 09:16:14 INFO - wsgiref == 0.1.2 09:16:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16: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')]} 09:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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')]} 09:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104beda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c82618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe6148af40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b51d30>, '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 0x1048b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b49b20>, '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.bkAtUQgLyl/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.eAgWcA4mGg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 09:16:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:16:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:16:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bkAtUQgLyl/Render', 09:16:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:14 INFO - 'HOME': '/Users/cltbld', 09:16:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:14 INFO - 'LOGNAME': 'cltbld', 09:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:14 INFO - 'MOZ_NO_REMOTE': '1', 09:16:14 INFO - 'NO_EM_RESTART': '1', 09:16:14 INFO - 'PAGER': '/bin/cat', 09:16:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:14 INFO - 'PWD': '/builds/slave/test', 09:16:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:14 INFO - 'SHELL': '/bin/bash', 09:16:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eAgWcA4mGg/Listeners', 09:16:14 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 09:16:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:14 INFO - 'USER': 'cltbld', 09:16:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:14 INFO - 'XPC_FLAGS': '0x0', 09:16:14 INFO - 'XPC_SERVICE_NAME': '0', 09:16:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:14 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)) 09:16:14 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)) 09:16:14 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)) 09:16:14 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)) 09:16:14 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)) 09:16:14 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)) 09:16:14 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)) 09:16:14 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)) 09:16:14 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)) 09:16:14 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)) 09:16:14 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)) 09:16:14 INFO - Cleaning up... 09:16:14 INFO - Return code: 0 09:16:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:16: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')]} 09:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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')]} 09:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:14 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 0x104beda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c82618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe6148af40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b51d30>, '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 0x1048b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b49b20>, '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.bkAtUQgLyl/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.eAgWcA4mGg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 09:16:14 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 09:16:14 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 09:16:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bkAtUQgLyl/Render', 09:16:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:14 INFO - 'HOME': '/Users/cltbld', 09:16:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:14 INFO - 'LOGNAME': 'cltbld', 09:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:14 INFO - 'MOZ_NO_REMOTE': '1', 09:16:14 INFO - 'NO_EM_RESTART': '1', 09:16:14 INFO - 'PAGER': '/bin/cat', 09:16:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:14 INFO - 'PWD': '/builds/slave/test', 09:16:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:14 INFO - 'SHELL': '/bin/bash', 09:16:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eAgWcA4mGg/Listeners', 09:16:14 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 09:16:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:14 INFO - 'USER': 'cltbld', 09:16:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:14 INFO - 'XPC_FLAGS': '0x0', 09:16:14 INFO - 'XPC_SERVICE_NAME': '0', 09:16:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:16:14 INFO - Cleaning up... 09:16:14 INFO - Return code: 0 09:16:14 INFO - Running post-action listener: _resource_record_post_action 09:16:14 INFO - Running post-action listener: _start_resource_monitoring 09:16:14 INFO - Starting resource monitoring. 09:16:14 INFO - [mozharness: 2016-08-22 16:16:14.595701Z] Finished create-virtualenv step (success) 09:16:14 INFO - [mozharness: 2016-08-22 16:16:14.596646Z] Running install step. 09:16:14 INFO - Running pre-action listener: _resource_record_pre_action 09:16:14 INFO - Running main action method: install 09:16:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:16:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:16:14 INFO - Reading from file tmpfile_stdout 09:16:14 INFO - Detecting whether we're running mozinstall >=1.0... 09:16:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:16:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:16:14 INFO - Reading from file tmpfile_stdout 09:16:14 INFO - Output received: 09:16:14 INFO - Usage: mozinstall [options] installer 09:16:14 INFO - Options: 09:16:14 INFO - -h, --help show this help message and exit 09:16:14 INFO - -d DEST, --destination=DEST 09:16:14 INFO - Directory to install application into. [default: 09:16:14 INFO - "/builds/slave/test"] 09:16:14 INFO - --app=APP Application being installed. [default: firefox] 09:16:14 INFO - mkdir: /builds/slave/test/build/application 09:16:14 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'] 09:16:14 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 09:16:49 INFO - Reading from file tmpfile_stdout 09:16:49 INFO - Output received: 09:16:49 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 09:16:49 INFO - Running post-action listener: _resource_record_post_action 09:16:49 INFO - [mozharness: 2016-08-22 16:16:49.575104Z] Finished install step (success) 09:16:49 INFO - [mozharness: 2016-08-22 16:16:49.575211Z] Running run-tests step. 09:16:49 INFO - Running pre-action listener: _resource_record_pre_action 09:16:49 INFO - Running main action method: run_tests 09:16:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:16:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:16:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:16:49 INFO - 2016-08-22 09:16:49.587 screenresolution[1635:7258] starting screenresolution argv=screenresolution get 09:16:49 INFO - 2016-08-22 09:16:49.589 screenresolution[1635:7258] Display 0: 1600x1200x32@60 09:16:49 INFO - 2016-08-22 09:16:49.594 screenresolution[1636:7260] starting screenresolution argv=screenresolution list 09:16:49 INFO - Available Modes on Display 0 09:16:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:16:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:16:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:16:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:16:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:16:49 INFO - Intel Iris: 09:16:49 INFO - Chipset Model: Intel Iris 09:16:49 INFO - Type: GPU 09:16:49 INFO - Bus: Built-In 09:16:49 INFO - VRAM (Dynamic, Max): 1536 MB 09:16:49 INFO - Vendor: Intel (0x8086) 09:16:49 INFO - Device ID: 0x0a2e 09:16:49 INFO - Revision ID: 0x0009 09:16:49 INFO - Displays: 09:16:49 INFO - Display: 09:16:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:16:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:16:49 INFO - Display Serial Number: 1600x1200 60 09:16:49 INFO - Main Display: Yes 09:16:49 INFO - Mirror: Off 09:16:49 INFO - Online: Yes 09:16:49 INFO - Rotation: Supported 09:16:49 INFO - Return code: 0 09:16:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:16:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:16:49 INFO - Python 2.7.3 09:16:49 INFO - Return code: 0 09:16:49 INFO - grabbing minidump binary from tooltool 09:16:49 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')]} 09:16:49 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 0x104b51d30>, '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 0x1048b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104b49b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:16:49 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 09:16:49 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 09:16:49 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 09:16:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:16:49 INFO - Return code: 0 09:16:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:16:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:16:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:16:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:16:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:16:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JINZnX9qTQuZ9Lu-BOmtJg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0322', '--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 09:16:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JINZnX9qTQuZ9Lu-BOmtJg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0322 --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 09:16:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bkAtUQgLyl/Render', 09:16:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:49 INFO - 'HOME': '/Users/cltbld', 09:16:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:49 INFO - 'LOGNAME': 'cltbld', 09:16:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:16:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:49 INFO - 'MOZ_NO_REMOTE': '1', 09:16:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:16:49 INFO - 'NO_EM_RESTART': '1', 09:16:49 INFO - 'PAGER': '/bin/cat', 09:16:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:49 INFO - 'PWD': '/builds/slave/test', 09:16:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:16:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:49 INFO - 'SHELL': '/bin/bash', 09:16:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eAgWcA4mGg/Listeners', 09:16:49 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 09:16:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:49 INFO - 'USER': 'cltbld', 09:16:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:49 INFO - 'XPC_FLAGS': '0x0', 09:16:49 INFO - 'XPC_SERVICE_NAME': '0', 09:16:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JINZnX9qTQuZ9Lu-BOmtJg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0322', '--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 09:16:50 INFO - mozversion application_buildid: 20160822064441 09:16:50 INFO - mozversion application_changeset: 194fe275b4e60ded2af6b25173eec421f0dba8ad 09:16:50 INFO - mozversion application_display_name: Nightly 09:16:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:16:50 INFO - mozversion application_name: Firefox 09:16:50 INFO - mozversion application_remotingname: firefox 09:16:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:16:50 INFO - mozversion application_vendor: Mozilla 09:16:50 INFO - mozversion application_version: 51.0a1 09:16:50 INFO - mozversion platform_buildid: 20160822064441 09:16:50 INFO - mozversion platform_changeset: 194fe275b4e60ded2af6b25173eec421f0dba8ad 09:16:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:16:50 INFO - mozversion platform_version: 51.0a1 09:16:50 INFO - using testdate: 1471882610 09:16:50 INFO - actual date: 1471882610 09:16:50 INFO - starting webserver on 'localhost:49271' 09:16:50 INFO - SUITE-START | Running 2 tests 09:16:50 INFO - TEST-START | dromaeo_css 09:16:50 INFO - operating with platform_type : mac_ 09:16:50 INFO - Initialising browser for dromaeo_css test... 09:16:50 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/tmpdc4teP/profile http://localhost:49271/getInfo.html) 09:16:52 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 09:16:52 INFO - PROCESS | 1646 | colorDepth:24 09:16:52 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 09:16:52 INFO - PROCESS | 1646 | __metrics 09:16:52 INFO - PROCESS | 1646 | 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" 09:16:52 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:16:53 INFO - TEST-INFO | 1646: exit 0 09:16:53 INFO - Browser initialized. 09:16:53 INFO - Running cycle 1/1 for dromaeo_css test... 09:16:53 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/tmpdc4teP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:17:05 INFO - PROCESS | 1649 | RSS: Main: 228904960 09:17:05 INFO - PROCESS | 1649 | 09:17:56 INFO - PROCESS | 1649 | 1471882676072 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] 09:20:07 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 09:20:09 INFO - PROCESS | 1649 | RSS: Main: 373112832 09:20:09 INFO - PROCESS | 1649 | 09:23:12 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 09:23:13 INFO - PROCESS | 1649 | RSS: Main: 374669312 09:23:13 INFO - PROCESS | 1649 | 09:26:15 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 09:26:16 INFO - PROCESS | 1649 | RSS: Main: 339292160 09:26:16 INFO - PROCESS | 1649 | 09:29:18 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 09:29:19 INFO - PROCESS | 1649 | RSS: Main: 341037056 09:29:19 INFO - PROCESS | 1649 | 09:32:22 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 09:32:23 INFO - PROCESS | 1649 | RSS: Main: 331620352 09:32:23 INFO - PROCESS | 1649 | 09:35:27 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 09:35:27 INFO - PROCESS | 1649 | RSS: Main: 424824832 09:35:27 INFO - PROCESS | 1649 | 09:35:27 INFO - PROCESS | 1649 | __start_tp_report 09:35:27 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 09:35:27 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 09:35:27 INFO - PROCESS | 1649 | |i|pagename|runs| 09:35:27 INFO - PROCESS | 1649 | |0;dojo.html;2915.4169166166766;3352.798832070075;3354.781939173955;3363.4282172030753;3393.7115345195657;5584.1902924075985;5656.802011929583;5680.659160450376;5760.4815566599;5774.769009239625;5647.181158731982;5712.942870571293;5716.542676585874;5717.485426311631;5726.484616384525;5157.896842063156;5203.739813009353;5213.791448342062;5242.55438287746;5265.262863199156;4671.944344488415;5163.63854530183;5364.222187782769;5365.704886231256;5365.946340536603;5181.378234611833;5348.358197016363;5353.170258609902;5358.410574836765;5369.543588794957;5138.972205558865;5165.509276618715;5285.7885684572575;5299.231611416361;5320.255164277004;5117.1556693145585;5134.435212126663;5154.484551544853;5161.096808058613;5188.429272779991;5656.4060773619;5731.455511726379;5769.24999750034;5791.21818554494;5805.390434004453;6102.511799056065;6170.228721409824;6286.402791734778;6287.549254133866;6321.273053598803;5523.972380138114;6285.340039295854;6302.779402720883;6317.810465686037;6320.146780184708;5844.620099693549;5856.326522449973;5859.121131830259;5869.618474799167;5882.088276317178;6227.221597300338;6246.562740608205;6285.465735412541;6296.685165741695;6304.275008374004;6132.049532322497;6187.102870083812;6198.721057552421;6206.162168107247;6212.47193988507;6277.591956522811;6292.811215663537;6295.527835412362;6299.937000630027;6349.746010159634;6046.546509011841;6164.537659675542;6170.691465426711;6249.468795152463;6254.843628909222;6230.43926046658;6244.313125556185;6276.372362763687;6286.779962701375;6305.716242769086;5002.449730529639;5012.924806127838;5026.195808670595;5036.597072234285;5037.967216720564;4358.978205108954;4447.466304043535;4488.4165058542185;4497.955020449754;4510.571495707903;5644.8024319148635;5673.6028478006965;5728.05487094633;5757.337906140848;5776.55205491769;6209.6895155242055;6222.066689996536;6224.751009959551;6224.875502489925;6246.812595622138;5528.391876893538;5653.406392328829;5756.280464941882;5764.020116580192;5780.71096445176;5334.333208348957;5403.594730395236;5406.107992181324;5422.186671999231;5422.864428389322;6302.779402720883;6305.905411418832;6326.43062124411;6331.27190373113;6350.523710721622;6216.347283535164;6239.469645080219;6245.125682404558;6259.6870156492905;6270.278917924497;6159.84600384994;6227.782027629011;6272.937270627418;6283.2774230962195;6304.148939893055;6201.193844800147;6210.285817130907;6228.813135605939;6236.03341482071;6236.594621349598;6227.844303892439;6228.346023667631;6231.189945307262;6234.0337247724865;6235.688215589294;5785.334686511105;5969.373215812451;6123.693815309306;6143.477804386498;6173.475254603409;6142.78500252489;6169.938300616936;6188.845278867884;6191.783287584913;6203.627782333075;5019.322391477104;5845.620034697731;6033.879322413615;6033.909491357721;6051.152838602511;5947.9702601486715;5979.402059793986;6070.332263451105;6160.199174107337;6190.442860142609;5890.352061273171;5896.351401345934;5928.436798504135;5945.167676525203;5953.285605727167 09:35:27 INFO - PROCESS | 1649 | |1;ext.html;517.3248910172225;517.8368813823644;528.2868128027163;529.1744877990335;546.784020311977;30707.539386909186;30958.53562196566;40094.59668911589;41393.586064139425;41748.58251417485;42898;43222.78388608061;43262.567374326245;43273.78363108188;43326;9625.518724063804;9803.901960980405;9812.852807207897;9814.362066465692;9817.803643927116;8755.562221888911;8965.103489651048;11872.584459543918;12116.575919842808;12175.269483830998;12041.458134383975;12110.576129835457;12150.39248037599;12156.939215303912;12160.574379896705;8800.823983520293;12001.579944701938;12125;12126.27242365452;12143.817842732322;11655.650330490014;11947.880521194851;11978.221415608044;12153.878461215452;12196.878031219663;40641.593584064074;40910.772676819746;40912;40955.795221023705;40968.59031409678;3380.1042723678247;3392.1519620094978;3417.0773891049525;3438.7249020078334;3493.458513930345;29925.850370748223;30598.69401305981;30621.693783062106;30708.232294192825;32492;3245.2049247934406;3365.209175843675;3385.4244778387733;3427.605825330069;3429.537012503305;482430;485436.99999999645;485996;486415;487220;57808.132878006865;58006.129908051415;58185.709071454374;58198.12702809461;58226;59483;59527.40472595305;59691.403085969454;59698;59707;16410.343586256415;16643.50069497917;16676.74984875228;16682.666346673243;16690.916545417196;9949.253805964581;11574;12966.611001669966;13030.934845325903;13037.956963442903;15528.456504022532;15658.68682626341;15864.682706345808;15868.20658967047;16253.268602912898;5596.916046259309;6388.680565971683;6441.32366101562;6464.191976003;6518.674066296666;848.8090179709516;951.8239125761756;991.9107280344804;1046.4767616191905;1086.8152414089623;29752;29980;30215.244618884703;30779.84610076935;30823.845880770452;985.3299756165733;1047.7956798424234;1138.4250953268547;1162.7093226693328;1182.603827717707;12784.872151278369;12985.35073246334;15265.465708700141;15631.218439078228;16191.83808161927;627417;631775;631939;632207.8389608023;633474;59112.7044364784;59598.70200649056;59672.70163649154;59791.70104149451;59859;1180.2092597959215;1228.2937311046185;1350.898682598809;1377.9242141682303;1388.465440805277;30239.395212095194;31199.660025498633;31287;31802.52296215605;32040.198995025312;49024.26463602977;49422.752886235336;49498.25752613642;49583.760405988694;49656.25515617341;523361.3831930816;526464;527140;527526;527801;22970.19604313841;25936.61095083613;26445.33886652849;26448.471030579665;39952.4007139899;47394.52605474039;47698.76150619225;48459;48491.515084850114;48951.26573101335;38646.420303694904;39111.80444097761;39273.60726392814;40827.59172408357;41136.97157571085;38857.6114238854;38879.028024299616;39164.80417597894;40358.596414036656;40799.79600101981;38093.047673808374;38790.6423275184;39078.6092139075;39410.80294598623;39458;31031.53452698166;33661.49507757337;34630.82684586561;34636.78771242994;34745.131371714895;21935.561288774454;23667.763322367246;25218.495630087662;25393.365165871;25823.870880645478 09:35:27 INFO - PROCESS | 1649 | |2;jquery.html;348.6391584709826;372.157064249475;376.6948771495087;382.7760759955426;400.21158318113305;15272.160031198293;16112.35550577977;20607.896960515212;20994.790052099514;21042.89478552609;18054.368097116603;20972.700596377745;21234.15063397466;21330.253441129564;21549.1380344786;5705.74324155414;5810.709464526778;5839.678817665027;6079.483243924272;6083.391660833903;4102.876913692594;5842.678652674102;5950.166976623254;5950.940490595082;5964.821055368346;6213.192285002966;6442.16251887254;6515.250746164204;6572.769953051644;6601.10885030522;5279.63042587019;5883.52931765462;5947.167396564484;6544.247411547662;6549.541532092731;5711.7715291388295;5749.971250143764;5754.510866576346;5760.596758226926;5782.248307720011;12379.947704445132;16628.25172867224;17773;25671;25895.870520647277;2256.7856053674873;2278.692376529164;2356.646503024543;2508.749125087495;2692.192342297303;9272.536373181381;9407.670731524364;9450.952745236298;9738.318317717763;9950.900490995069;1756.7540544323806;1820.6085691576243;1842.3367587668429;1902.4958386027713;1929.7394851695121;111798.88201117967;116280.41859790646;118752;120071;122162;11231.21381503287;11290.604828830952;11417.48621312043;11450.255733377304;11631.709207269716;14344.426222950966;14398.784018239734;14400.343960444683;14401.63995900111;14455.78316325256;7355.963220183865;8169.101398846122;8352.039515455679;8604.913950860537;8632.136786321318;8507;8507.191816777397;8528.848605438186;8695.347848911231;8725.738227853175;4005.2990726622725;4240.639545638655;4383;4452.154090722753;4524.615407690318;1595.611817718569;1789.6689112514227;1830.688782906909;1838.1911958738112;1925.5859990102194;837.1252041616525;855.9186877246651;919.4942781470164;942.7784470649392;996.858596906538;21062.894685526473;21511.784882151293;21810.672839907413;21909.452263693536;21948.780512194993;721.6932803558572;907.6188001039447;936.9437833729862;953.208836665566;979.8829334558609;10763.461826908624;11386.202965792316;11410.771784564262;11485.483153258123;11490.368029758443;510521;591765;599597;610570;613655;95415.52292238495;107848;115783.42108289404;127255;127470.36264818617;831.1314676163303;874.9825003499894;952.4095061062047;1027.6095083868083;1027.9023492768174;19593.179330030507;20083.096260668597;20317.49206269855;20332.08505617221;20377;49649.255261171835;54186.72906635599;55416.72291638516;56584.717076416004;57909.71045144747;77160.6141969309;77709;79373.20626793658;79403.60298198472;80864.19135808566;10234.539445724811;10501.739791225102;12129.090318226345;12419.130660853654;12579.371031448574;11429.657110286706;12888.935555322163;13709.245991470565;14301.284935752963;14393.712125757636;10694.358338499715;11121.83317250258;11258.437078145897;11700.531978720755;11829.52681892749;11381.943090284496;11507.769844602893;11599.478023488795;11957.521699132285;11960.222585531912;11519.942400287944;11603.36181510025;12039.578614748441;12100.334481603597;12140.939295303468;11966.58116965902;12072.215306005082;12143.574974875837;12181.817272740738;12405.503779849067;11640.94179529097;11827.526898923947;11838.526458941546;11939.223950443193;12003.459844306852 09:35:27 INFO - PROCESS | 1649 | |3;mootools.html;1485.636019175302;1534.6777176792873;1675.271257003203;1786.2140658110422;1817.1641045119245;8033.1565185655545;8511.10633383495;8526.360522960771;8539.146085391465;8543.06026337104;6249;7686.96156519218;8019.157988411206;8237.464564803284;8320.875186872201;2292.9541409171766;2329.452578644017;2331.079223706635;2331.533693261346;2345.6129738593113;2288.1305104060516;2301.827362947777;2338.8596684199;2339.263132113379;2342.9765702343016;2294.1511640692966;2304.1820153845397;2316.3514216019544;2335.754745751697;2338.9766102339013;2293.243229734184;2300.769923007703;2301.873396963183;2302.802542677798;2304.6197377432704;2294.954100917989;2297.356740112771;2301.2290882554366;2302.251768175333;2323.1520495019367;8370.372222083308;8392.244697977212;8450.957745211295;8465.830683386297;8471.576421178977;4921.704697718113;5077.314562534048;5079.23811428285;5080.568151707109;5095.668781529226;3078.122735020531;3102.4177669388773;3250.333681595267;3255.706986371238;3265.7713960022807;1106.8339749037627;1109.2013750099916;1114.804909140897;1130.6268931252666;1134.6936327191613;10794.946025269823;10847.349159050404;10867.456627168689;10877.67366978992;10898.182636302308;4283.914321713548;4333.479982402132;4463.799129039201;4489.393931819162;4515.909681806345;9351.205147562398;9379.108984646447;9381.202597779129;9420.43477391345;9491.620335186653;5048.848534543969;5049.091163590516;5053.267276244924;5064.696118232918;5066.797328106834;3521.8239088046007;4195.622393984556;4253.914921701548;4353.586409291112;4626.907461850744;3485.8605655773486;3874.7526434667825;3875.5079294471266;3904.121572646132;3929.5677475477673;1274.1144904291427;1276.2342594443446;1276.8084787281796;1297.344840855362;1301.9088663793443;894.4901406198404;923.7690577355661;932.6735642525061;932.9207017403461;977.880327025566;5149.613778966593;5534.75093620788;5723.198752174699;5848.883022339614;5872.559558033079;810.0603300171772;905.42053086025;967.2213867836318;981.7300242433388;1004.3622299839508;3412.3857705613227;3546.5034895114704;3787.7348585598743;3844.231153769257;3975.960240397617;9911.504424778732;10125.291229614004;10224.335418197794;10309.329893556895;10352.430616316024;10191.694249172537;10193.439360835226;10200.846987295197;10237.74405639865;10239.692809215736;7733.922660773433;7856.646450909723;7894.723684671124;7908.051033875971;7909.209079092045;4024.63778259958;5706.572007099568;5750.194972703908;5758.769649214152;5773.191753154646;9068.818623627623;9219.953900230725;9474.621015159317;9573.856392153984;9583.808323833346;8129.674813007414;9017.05320941318;9364.157225849705;9430.52847357643;9699.224062075158;6764.458843292623;7905.01187351581;7923.84152316962;7929.603519823871;7989.880151797612;7870.881936771068;7952.125266220827;7960.880586791087;8057.798555036171;8120.9848768903885;7141.85716285661;7156.749513766993;7194.100737407824;7201.963990180225;7238.782836514913;7001.789946301619;7042.647867606702;7064.788056358318;7071.575705457689;7078.292170782881;6694.230163531061;6766.004028811414;6774;6782.728690852311;6798.354156355138;4818.759062046954;4922.286268490977;4940.962397896338;4996.225585034325;5086.18621020635;4418.939454530953;4476.79854406559;4733.83431579893;4956.752162391938;5006.574441172395 09:35:27 INFO - PROCESS | 1649 | |4;prototype.html;290.59316956261233;295.28835506429505;304.91602353632834;307.68616011668115;310.964239112502;5405.35135783706;5443.108177652977;5456.972715136424;5483.643563168392;5483.8080667176655;4571.90856182877;5276.630635855492;5318.042752304584;5326.414094449608;5344.599155063366;3449.637788032258;3774.792386418746;4064.166845796612;4113.609207125318;4153.563875793044;4086.1419101988618;4108.15782764534;4118.878777429626;4147.921540399503;4216.156768646283;3856.9971807330157;4042.4946881639794;4072.8981775455554;4078.6125318094882;4094.467719196515;3768.453574231735;4090.0797320602924;4115.691323150746;4138.627523522882;4149.170165966819;3536.885880947493;3564.322778672044;3593.729705967583;3603.837827297778;3623.8188090595363;4813.796550862285;5146.8198613048735;5251.238570407308;5286.867828304285;5318.414974352818;4409.669274804402;4772.164871147535;4777.63837306366;4783.473817880031;4791.832285869978;5680.847129842936;5683.658980461186;5703.857403564903;5709.115087161496;5738.684372359518;3383.627800941919;3470.993411910543;3491.3890069238037;3982.422548730418;3982.542007669097;4862.7568621569135;5235.743421578832;5617.9719101404235;5892.469677729025;5909.763609455659;4051.4125451809914;4065.3738504598396;4066.512018557733;4080.5103387593085;4083.2037752637953;4089.5297040840087;4100.630943215125;4102.938455923164;4104.445899803488;4145.17096580679;4016.9397459038137;4038.7172897896867;4486.026148494652;4678.883027924261;4767.118083154558;4931.876703082452;5571.9721401392735;5700.572457065737;5702.429757024264;5730.570207234474;1323.206076354199;1387.3826147364325;1397.9380413889635;1418.985810141906;1425.565202613213;873.5675840459013;891.4918496457087;900.6625161634967;952.9618815247451;954.3224310739314;4779.880502987453;5206.271122042917;5236.895262094737;5260.28986086881;5270.868228294246;4975.651704380731;5689.6586204827845;5760.971195144081;5770.826875193751;5786.913196302059;4974.403071631355;5187.818426355059;5189.6886186828915;5268.868278293074;5335.306410166653;2529.165375426105;2739.602757600137;2820.3513191965963;3057.29429454934;3060.4032213718556;5087.771050302746;5960.284765828128;6036.909446358308;6059.272887253558;6095.664738439428;5112.268044327661;5787.739551720183;5978.730957106941;5985.581009329305;6029.125776762433;4979.751012449291;5335.466453354634;5954.367835620268;6009.677870868402;6126.754929802847;4507.481049331249;5602.803901863415;5783.277090363705;5834.416558344132;5898.083122984961;5809.767609295581;5817.650940943557;5829.679367634821;5834.103916227328;5849.883002340014;5278.97360513195;5725.914111288251;6082.36135205797;6093.6039157454625;6102.558976409294;3730.589635140078;3788.715846311593;3844.4814298351434;3903.8633647823326;3965.504311961005;5491.450854914477;5632.662040277596;5753.360292316837;5782.3639399666845;5892.705364731661;4643.558861908114;4650.9767451162525;5397.487238712473;5624.943750562442;5681.914771278517;4746.955669752649;4952.380952380952;5627.943720562742;5692.772289108555;5723.255976723;5164.896702065863;5193.870153246199;5294.682319060868;5397.379301380392;5599.076152434803;4569.794359253775;4616.722996620214;4683.1336202802595;5567.10926251814;5603.691796951207;4614.584687378152;4869.80689731004;5196.818111366084;5495.835124946258;5584.664920104807 09:35:27 INFO - PROCESS | 1649 | |5;yui.html;701.8455939693267;730.6565914020408;762.1121393576484;789.1713700614354;835.390165179419;15003.174825384613;15071.095734255925;15699;15722.685546289067;15804.604884877885;13952.860471395283;14256.572302830931;14290;14294.428222871073;14782.260886955635;669.4744625469008;693.6843736100062;850.387720840995;871.9215270625642;874.807542340684;696.1228851646911;698.2214830464047;698.9091418115638;698.9336013078749;839.5256679975824;913.584319134792;920.1212841736126;925.2736601767614;925.5372313843078;927.9977624165919;917.9127982841619;918.0589895357278;918.7106061590578;919.3518569408551;921.1065266691298;524.9658772179796;645.8514541655445;674.9730010799611;675.5237557521936;677.1231255524108;15190.392384304725;15299.388024479007;15299.541013769605;15329.386824527006;15371.385144594204;13983.440662373594;14335.781458576033;14353;14380.712385752331;14408.71182576353;12928.612141635766;13025.934870325682;13047.739045219138;13216.86783132166;13251.13867598603;4651.88370290742;4771.475137734847;4784.712917224978;4803.18345881201;4896.951030489685;99391;100446.4799084043;101186.49406752993;104901.4754926228;105015;10645.78708425827;10887.510062047228;11008.339499630049;11043.668689939315;11411.315321080761;22045.228417005328;22120.44698882541;22131.00410481532;22136.335909922727;22149.889250553966;7637.656305466267;7712.498687585289;7735.961320193475;7798.064232292161;7860.135385107634;3729.5151630287887;3814.675752561008;4374.212641724456;4422.690411671217;4566.840160594364;3230.9030729078167;3295.6374798772117;3313.801171929692;3314.552535407689;3317.552130462405;592.0586267834078;599.9040153575407;600.5285850607339;615.8860610787019;622.5579838314848;576.9394213607595;614.4040280927493;622.5673157155733;628.707650942314;629.087822657149;7691.923080769233;9019;9210.815783684422;9247.815043699089;9298.767530811649;526.3210458508557;540.3495852841817;558.4387690371232;563.2649392542771;585.3619554685413;3584.5698516178227;4424.623906967944;4442.400275962704;4444.422225110715;4562.24722920721;95476;124517.75482245062;163616.3638363625;164059;164756;98156;121092;126606;128123;128808;72409;102986.48506757418;105058;107640.46179769207;111302;8421.578921054046;8628.180322869317;8661.653533858575;9251.722448326562;9271.072892710676;43752;48478.27282590693;55235.895282094934;60087;61153.38846611477;64020;73067;73767.63116184385;77406.22593774216;87125.56437218026;13311.80032299497;13390;13442.460317460318;13446.327683615584;13880.652983675489;14729.116253024853;14850.331735072165;15069.397224110913;15080.932880195436;15276.465323714061;14041.36813843359;14087.929560352133;14234.288285585471;14503.85496145025;14517.201553914636;10794.460276985963;13594.320283985564;13906;13910.652233694238;14358.641033974234;13103.2138071716;13558.38987245596;13590.77683008534;13641;13749.862501374859;10995.615153469591;11318.151138664469;11364.772704546029;11514.251573647685;11621.593244236412;11345.763540165366;11386.94306528462;11503.539858405904;11559;11691.064714822964 09:35:27 INFO - PROCESS | 1649 | __end_tp_report 09:35:27 INFO - PROCESS | 1649 | __start_cc_report 09:35:27 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,1452 09:35:27 INFO - PROCESS | 1649 | __end_cc_report 09:35:27 INFO - PROCESS | 1649 | __startTimestamp1471883727329__endTimestamp 09:35:27 INFO - PROCESS | 1649 | 09:35:27 INFO - PROCESS | 1649 | ------- Summary: start ------- 09:35:27 INFO - PROCESS | 1649 | Number of tests: 6 09:35:27 INFO - PROCESS | 1649 | 09:35:27 INFO - PROCESS | 1649 | [#0] dojo.html Cycles:165 Average:5751.38 Median:5945.17 stddev:649.35 (10.9%) stddev-sans-first:612.04 09:35:27 INFO - PROCESS | 1649 | Values: 2915.4 3352.8 3354.8 3363.4 3393.7 5584.2 5656.8 5680.7 5760.5 5774.8 5647.2 5712.9 5716.5 5717.5 5726.5 5157.9 5203.7 5213.8 5242.6 5265.3 4671.9 5163.6 5364.2 5365.7 5365.9 5181.4 5348.4 5353.2 5358.4 5369.5 5139.0 5165.5 5285.8 5299.2 5320.3 5117.2 5134.4 5154.5 5161.1 5188.4 5656.4 5731.5 5769.2 5791.2 5805.4 6102.5 6170.2 6286.4 6287.5 6321.3 5524.0 6285.3 6302.8 6317.8 6320.1 5844.6 5856.3 5859.1 5869.6 5882.1 6227.2 6246.6 6285.5 6296.7 6304.3 6132.0 6187.1 6198.7 6206.2 6212.5 6277.6 6292.8 6295.5 6299.9 6349.7 6046.5 6164.5 6170.7 6249.5 6254.8 6230.4 6244.3 6276.4 6286.8 6305.7 5002.4 5012.9 5026.2 5036.6 5038.0 4359.0 4447.5 4488.4 4498.0 4510.6 5644.8 5673.6 5728.1 5757.3 5776.6 6209.7 6222.1 6224.8 6224.9 6246.8 5528.4 5653.4 5756.3 5764.0 5780.7 5334.3 5403.6 5406.1 5422.2 5422.9 6302.8 6305.9 6326.4 6331.3 6350.5 6216.3 6239.5 6245.1 6259.7 6270.3 6159.8 6227.8 6272.9 6283.3 6304.1 6201.2 6210.3 6228.8 6236.0 6236.6 6227.8 6228.3 6231.2 6234.0 6235.7 5785.3 5969.4 6123.7 6143.5 6173.5 6142.8 6169.9 6188.8 6191.8 6203.6 5019.3 5845.6 6033.9 6033.9 6051.2 5948.0 5979.4 6070.3 6160.2 6190.4 5890.4 5896.4 5928.4 5945.2 5953.3 09:35:27 INFO - PROCESS | 1649 | 09:35:27 INFO - PROCESS | 1649 | [#1] ext.html Cycles:180 Average:68581.51 Median:38824.13 stddev:147042.60 (378.7%) stddev-sans-first:147366.29 09:35:27 INFO - PROCESS | 1649 | Values: 517.3 517.8 528.3 529.2 546.8 30707.5 30958.5 40094.6 41393.6 41748.6 42898.0 43222.8 43262.6 43273.8 43326.0 9625.5 9803.9 9812.9 9814.4 9817.8 8755.6 8965.1 11872.6 12116.6 12175.3 12041.5 12110.6 12150.4 12156.9 12160.6 8800.8 12001.6 12125.0 12126.3 12143.8 11655.7 11947.9 11978.2 12153.9 12196.9 40641.6 40910.8 40912.0 40955.8 40968.6 3380.1 3392.2 3417.1 3438.7 3493.5 29925.9 30598.7 30621.7 30708.2 32492.0 3245.2 3365.2 3385.4 3427.6 3429.5 482430.0 485437.0 485996.0 486415.0 487220.0 57808.1 58006.1 58185.7 58198.1 58226.0 59483.0 59527.4 59691.4 59698.0 59707.0 16410.3 16643.5 16676.7 16682.7 16690.9 9949.3 11574.0 12966.6 13030.9 13038.0 15528.5 15658.7 15864.7 15868.2 16253.3 5596.9 6388.7 6441.3 6464.2 6518.7 848.8 951.8 991.9 1046.5 1086.8 29752.0 29980.0 30215.2 30779.8 30823.8 985.3 1047.8 1138.4 1162.7 1182.6 12784.9 12985.4 15265.5 15631.2 16191.8 627417.0 631775.0 631939.0 632207.8 633474.0 59112.7 59598.7 59672.7 59791.7 59859.0 1180.2 1228.3 1350.9 1377.9 1388.5 30239.4 31199.7 31287.0 31802.5 32040.2 49024.3 49422.8 49498.3 49583.8 49656.3 523361.4 526464.0 527140.0 527526.0 527801.0 22970.2 25936.6 26445.3 26448.5 39952.4 47394.5 47698.8 48459.0 48491.5 48951.3 38646.4 39111.8 39273.6 40827.6 41137.0 38857.6 38879.0 39164.8 40358.6 40799.8 38093.0 38790.6 39078.6 39410.8 39458.0 31031.5 33661.5 34630.8 34636.8 34745.1 21935.6 23667.8 25218.5 25393.4 25823.9 09:35:27 INFO - PROCESS | 1649 | 09:35:27 INFO - PROCESS | 1649 | [#2] jquery.html Cycles:180 Average:34524.23 Median:21679.91 stddev:97663.96 (450.5%) stddev-sans-first:97904.22 09:35:27 INFO - PROCESS | 1649 | Values: 348.6 372.2 376.7 382.8 400.2 15272.2 16112.4 20607.9 20994.8 21042.9 18054.4 20972.7 21234.2 21330.3 21549.1 5705.7 5810.7 5839.7 6079.5 6083.4 4102.9 5842.7 5950.2 5950.9 5964.8 6213.2 6442.2 6515.3 6572.8 6601.1 5279.6 5883.5 5947.2 6544.2 6549.5 5711.8 5750.0 5754.5 5760.6 5782.2 12379.9 16628.3 17773.0 25671.0 25895.9 2256.8 2278.7 2356.6 2508.7 2692.2 9272.5 9407.7 9451.0 9738.3 9950.9 1756.8 1820.6 1842.3 1902.5 1929.7 111798.9 116280.4 118752.0 120071.0 122162.0 11231.2 11290.6 11417.5 11450.3 11631.7 14344.4 14398.8 14400.3 14401.6 14455.8 7356.0 8169.1 8352.0 8604.9 8632.1 8507.0 8507.2 8528.8 8695.3 8725.7 4005.3 4240.6 4383.0 4452.2 4524.6 1595.6 1789.7 1830.7 1838.2 1925.6 837.1 855.9 919.5 942.8 996.9 21062.9 21511.8 21810.7 21909.5 21948.8 721.7 907.6 936.9 953.2 979.9 10763.5 11386.2 11410.8 11485.5 11490.4 510521.0 591765.0 599597.0 610570.0 613655.0 95415.5 107848.0 115783.4 127255.0 127470.4 831.1 875.0 952.4 1027.6 1027.9 19593.2 20083.1 20317.5 20332.1 20377.0 49649.3 54186.7 55416.7 56584.7 57909.7 77160.6 77709.0 79373.2 79403.6 80864.2 10234.5 10501.7 12129.1 12419.1 12579.4 11429.7 12888.9 13709.2 14301.3 14393.7 10694.4 11121.8 11258.4 11700.5 11829.5 11381.9 11507.8 11599.5 11957.5 11960.2 11519.9 11603.4 12039.6 12100.3 12140.9 11966.6 12072.2 12143.6 12181.8 12405.5 11640.9 11827.5 11838.5 11939.2 12003.5 09:35:27 INFO - PROCESS | 1649 | 09:35:27 INFO - PROCESS | 1649 | [#3] mootools.html Cycles:180 Average:5442.39 Median:5027.71 stddev:3006.40 (59.8%) stddev-sans-first:3000.13 09:35:27 INFO - PROCESS | 1649 | Values: 1485.6 1534.7 1675.3 1786.2 1817.2 8033.2 8511.1 8526.4 8539.1 8543.1 6249.0 7687.0 8019.2 8237.5 8320.9 2293.0 2329.5 2331.1 2331.5 2345.6 2288.1 2301.8 2338.9 2339.3 2343.0 2294.2 2304.2 2316.4 2335.8 2339.0 2293.2 2300.8 2301.9 2302.8 2304.6 2295.0 2297.4 2301.2 2302.3 2323.2 8370.4 8392.2 8451.0 8465.8 8471.6 4921.7 5077.3 5079.2 5080.6 5095.7 3078.1 3102.4 3250.3 3255.7 3265.8 1106.8 1109.2 1114.8 1130.6 1134.7 10794.9 10847.3 10867.5 10877.7 10898.2 4283.9 4333.5 4463.8 4489.4 4515.9 9351.2 9379.1 9381.2 9420.4 9491.6 5048.8 5049.1 5053.3 5064.7 5066.8 3521.8 4195.6 4253.9 4353.6 4626.9 3485.9 3874.8 3875.5 3904.1 3929.6 1274.1 1276.2 1276.8 1297.3 1301.9 894.5 923.8 932.7 932.9 977.9 5149.6 5534.8 5723.2 5848.9 5872.6 810.1 905.4 967.2 981.7 1004.4 3412.4 3546.5 3787.7 3844.2 3976.0 9911.5 10125.3 10224.3 10309.3 10352.4 10191.7 10193.4 10200.8 10237.7 10239.7 7733.9 7856.6 7894.7 7908.1 7909.2 4024.6 5706.6 5750.2 5758.8 5773.2 9068.8 9220.0 9474.6 9573.9 9583.8 8129.7 9017.1 9364.2 9430.5 9699.2 6764.5 7905.0 7923.8 7929.6 7989.9 7870.9 7952.1 7960.9 8057.8 8121.0 7141.9 7156.7 7194.1 7202.0 7238.8 7001.8 7042.6 7064.8 7071.6 7078.3 6694.2 6766.0 6774.0 6782.7 6798.4 4818.8 4922.3 4941.0 4996.2 5086.2 4418.9 4476.8 4733.8 4956.8 5006.6 09:35:27 INFO - PROCESS | 1649 | 09:35:27 INFO - PROCESS | 1649 | [#4] prototype.html Cycles:180 Average:4574.40 Median:5155.86 stddev:1392.46 (27.0%) stddev-sans-first:1358.74 09:35:27 INFO - PROCESS | 1649 | Values: 290.6 295.3 304.9 307.7 311.0 5405.4 5443.1 5457.0 5483.6 5483.8 4571.9 5276.6 5318.0 5326.4 5344.6 3449.6 3774.8 4064.2 4113.6 4153.6 4086.1 4108.2 4118.9 4147.9 4216.2 3857.0 4042.5 4072.9 4078.6 4094.5 3768.5 4090.1 4115.7 4138.6 4149.2 3536.9 3564.3 3593.7 3603.8 3623.8 4813.8 5146.8 5251.2 5286.9 5318.4 4409.7 4772.2 4777.6 4783.5 4791.8 5680.8 5683.7 5703.9 5709.1 5738.7 3383.6 3471.0 3491.4 3982.4 3982.5 4862.8 5235.7 5618.0 5892.5 5909.8 4051.4 4065.4 4066.5 4080.5 4083.2 4089.5 4100.6 4102.9 4104.4 4145.2 4016.9 4038.7 4486.0 4678.9 4767.1 4931.9 5572.0 5700.6 5702.4 5730.6 1323.2 1387.4 1397.9 1419.0 1425.6 873.6 891.5 900.7 953.0 954.3 4779.9 5206.3 5236.9 5260.3 5270.9 4975.7 5689.7 5761.0 5770.8 5786.9 4974.4 5187.8 5189.7 5268.9 5335.3 2529.2 2739.6 2820.4 3057.3 3060.4 5087.8 5960.3 6036.9 6059.3 6095.7 5112.3 5787.7 5978.7 5985.6 6029.1 4979.8 5335.5 5954.4 6009.7 6126.8 4507.5 5602.8 5783.3 5834.4 5898.1 5809.8 5817.7 5829.7 5834.1 5849.9 5279.0 5725.9 6082.4 6093.6 6102.6 3730.6 3788.7 3844.5 3903.9 3965.5 5491.5 5632.7 5753.4 5782.4 5892.7 4643.6 4651.0 5397.5 5624.9 5681.9 4747.0 4952.4 5627.9 5692.8 5723.3 5164.9 5193.9 5294.7 5397.4 5599.1 4569.8 4616.7 4683.1 5567.1 5603.7 4614.6 4869.8 5196.8 5495.8 5584.7 09:35:27 INFO - PROCESS | 1649 | 09:35:27 INFO - PROCESS | 1649 | [#5] yui.html Cycles:180 Average:23348.75 Median:3451.06 stddev:36832.59 (1067.3%) stddev-sans-first:36896.66 09:35:27 INFO - PROCESS | 1649 | Values: 701.8 730.7 762.1 789.2 835.4 15003.2 15071.1 15699.0 15722.7 15804.6 13952.9 14256.6 14290.0 14294.4 14782.3 669.5 693.7 850.4 871.9 874.8 696.1 698.2 698.9 698.9 839.5 913.6 920.1 925.3 925.5 928.0 917.9 918.1 918.7 919.4 921.1 525.0 645.9 675.0 675.5 677.1 15190.4 15299.4 15299.5 15329.4 15371.4 13983.4 14335.8 14353.0 14380.7 14408.7 12928.6 13025.9 13047.7 13216.9 13251.1 4651.9 4771.5 4784.7 4803.2 4897.0 99391.0 100446.5 101186.5 104901.5 105015.0 10645.8 10887.5 11008.3 11043.7 11411.3 22045.2 22120.4 22131.0 22136.3 22149.9 7637.7 7712.5 7736.0 7798.1 7860.1 3729.5 3814.7 4374.2 4422.7 4566.8 3230.9 3295.6 3313.8 3314.6 3317.6 592.1 599.9 600.5 615.9 622.6 576.9 614.4 622.6 628.7 629.1 7691.9 9019.0 9210.8 9247.8 9298.8 526.3 540.3 558.4 563.3 585.4 3584.6 4424.6 4442.4 4444.4 4562.2 95476.0 124517.8 163616.4 164059.0 164756.0 98156.0 121092.0 126606.0 128123.0 128808.0 72409.0 102986.5 105058.0 107640.5 111302.0 8421.6 8628.2 8661.7 9251.7 9271.1 43752.0 48478.3 55235.9 60087.0 61153.4 64020.0 73067.0 73767.6 77406.2 87125.6 13311.8 13390.0 13442.5 13446.3 13880.7 14729.1 14850.3 15069.4 15080.9 15276.5 14041.4 14087.9 14234.3 14503.9 14517.2 10794.5 13594.3 13906.0 13910.7 14358.6 13103.2 13558.4 13590.8 13641.0 13749.9 10995.6 11318.2 11364.8 11514.3 11621.6 11345.8 11386.9 11503.5 11559.0 11691.1 09:35:27 INFO - PROCESS | 1649 | -------- Summary: end -------- 09:35:27 INFO - PROCESS | 1649 | 09:35:27 INFO - TEST-INFO | 1649: exit 0 09:35:27 INFO - TEST-OK | dromaeo_css | took 1117730ms 09:35:27 INFO - TEST-START | kraken 09:35:27 INFO - operating with platform_type : mac_ 09:35:27 INFO - Initialising browser for kraken test... 09:35:27 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/tmpwCQn9c/profile http://localhost:49271/getInfo.html) 09:35:30 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 09:35:30 INFO - PROCESS | 1660 | colorDepth:24 09:35:30 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 09:35:30 INFO - PROCESS | 1660 | __metrics 09:35:30 INFO - PROCESS | 1660 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:35:30 INFO - PROCESS | 1660 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:35:30 INFO - TEST-INFO | 1660: exit 0 09:35:30 INFO - Browser initialized. 09:35:30 INFO - Running cycle 1/1 for kraken test... 09:35:30 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/tmpwCQn9c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:35:42 INFO - PROCESS | 1662 | RSS: Main: 228761600 09:35:42 INFO - PROCESS | 1662 | 09:35:45 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 09:35:46 INFO - PROCESS | 1662 | RSS: Main: 293986304 09:35:46 INFO - PROCESS | 1662 | 09:35:48 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 09:35:49 INFO - PROCESS | 1662 | RSS: Main: 294699008 09:35:49 INFO - PROCESS | 1662 | 09:35:53 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 09:35:54 INFO - PROCESS | 1662 | RSS: Main: 382722048 09:35:54 INFO - PROCESS | 1662 | 09:35:56 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 09:35:56 INFO - PROCESS | 1662 | RSS: Main: 282779648 09:35:56 INFO - PROCESS | 1662 | 09:35:58 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:35:59 INFO - PROCESS | 1662 | RSS: Main: 287694848 09:35:59 INFO - PROCESS | 1662 | 09:36:02 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 09:36:02 INFO - PROCESS | 1662 | RSS: Main: 325640192 09:36:02 INFO - PROCESS | 1662 | 09:36:05 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 09:36:06 INFO - PROCESS | 1662 | RSS: Main: 326152192 09:36:06 INFO - PROCESS | 1662 | 09:36:09 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 09:36:09 INFO - PROCESS | 1662 | RSS: Main: 324853760 09:36:09 INFO - PROCESS | 1662 | 09:36:11 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:36:12 INFO - PROCESS | 1662 | RSS: Main: 302706688 09:36:12 INFO - PROCESS | 1662 | 09:36:13 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:36:14 INFO - PROCESS | 1662 | RSS: Main: 303255552 09:36:14 INFO - PROCESS | 1662 | 09:36:16 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:36:17 INFO - PROCESS | 1662 | RSS: Main: 310820864 09:36:17 INFO - PROCESS | 1662 | 09:36:20 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:36:21 INFO - PROCESS | 1662 | RSS: Main: 315346944 09:36:21 INFO - PROCESS | 1662 | 09:36:23 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:36:24 INFO - PROCESS | 1662 | RSS: Main: 317956096 09:36:24 INFO - PROCESS | 1662 | 09:36:26 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 09:36:26 INFO - PROCESS | 1662 | RSS: Main: 360935424 09:36:26 INFO - PROCESS | 1662 | 09:36:26 INFO - PROCESS | 1662 | __start_tp_report 09:36:26 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 09:36:26 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 09:36:26 INFO - PROCESS | 1662 | |i|pagename|runs| 09:36:26 INFO - PROCESS | 1662 | |0;ai-astar;99;113;108;112;113;113;116;112;112;112 09:36:26 INFO - PROCESS | 1662 | |1;audio-beat-detection;144;104;131;188;136;138;126;107;177;137 09:36:26 INFO - PROCESS | 1662 | |2;audio-dft;186;184;186;182;182;197;237;243;262;184 09:36:26 INFO - PROCESS | 1662 | |3;audio-fft;74;74;75;148;60;81;86;129;93;58 09:36:26 INFO - PROCESS | 1662 | |4;audio-oscillator;83;90;137;70;72;70;117;71;69;119 09:36:26 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;90;87;92;88;90;87;91;89;91;87 09:36:26 INFO - PROCESS | 1662 | |6;imaging-darkroom;95;96;96;122;149;99;96;96;96;96 09:36:26 INFO - PROCESS | 1662 | |7;imaging-desaturate;84;84;86;86;86;87;86;84;86;84 09:36:26 INFO - PROCESS | 1662 | |8;json-parse-financial;56;52;55;54;54;54;54;55;54;54 09:36:26 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;68;65;72;81;74;72;70;70;70;70 09:36:26 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;83;81;89;84;87;88;87;85;86;87 09:36:26 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;151;142;137;138;138;138;138;157;217;138 09:36:26 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;167;169;168;167;169;169;171;148;148;201 09:36:26 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;68;69;74;85;87;86;76;66;67;69 09:36:26 INFO - PROCESS | 1662 | __end_tp_report 09:36:26 INFO - PROCESS | 1662 | __start_cc_report 09:36:26 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,2117 09:36:26 INFO - PROCESS | 1662 | __end_cc_report 09:36:26 INFO - PROCESS | 1662 | __startTimestamp1471883786641__endTimestamp 09:36:26 INFO - PROCESS | 1662 | 09:36:26 INFO - PROCESS | 1662 | ------- Summary: start ------- 09:36:26 INFO - PROCESS | 1662 | Number of tests: 14 09:36:26 INFO - PROCESS | 1662 | 09:36:26 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:111.00 Median:113.00 stddev:4.64 (4.1%) stddev-sans-first:2.06 09:36:26 INFO - PROCESS | 1662 | Values: 99.0 113.0 108.0 112.0 113.0 113.0 116.0 112.0 112.0 112.0 09:36:26 INFO - PROCESS | 1662 | 09:36:26 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:138.80 Median:137.50 stddev:26.59 (19.3%) stddev-sans-first:28.14 09:36:26 INFO - PROCESS | 1662 | Values: 144.0 104.0 131.0 188.0 136.0 138.0 126.0 107.0 177.0 137.0 09:36:26 INFO - PROCESS | 1662 | 09:36:26 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:204.30 Median:191.50 stddev:30.62 (16.0%) stddev-sans-first:31.75 09:36:26 INFO - PROCESS | 1662 | Values: 186.0 184.0 186.0 182.0 182.0 197.0 237.0 243.0 262.0 184.0 09:36:26 INFO - PROCESS | 1662 | 09:36:26 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:87.80 Median:74.50 stddev:29.07 (39.0%) stddev-sans-first:30.40 09:36:26 INFO - PROCESS | 1662 | Values: 74.0 74.0 75.0 148.0 60.0 81.0 86.0 129.0 93.0 58.0 09:36:26 INFO - PROCESS | 1662 | 09:36:26 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:70.50 stddev:25.28 (35.9%) stddev-sans-first:26.70 09:36:26 INFO - PROCESS | 1662 | Values: 83.0 90.0 137.0 70.0 72.0 70.0 117.0 71.0 69.0 119.0 09:36:26 INFO - PROCESS | 1662 | 09:36:26 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:89.20 Median:90.00 stddev:1.87 (2.1%) stddev-sans-first:1.96 09:36:26 INFO - PROCESS | 1662 | Values: 90.0 87.0 92.0 88.0 90.0 87.0 91.0 89.0 91.0 87.0 09:36:26 INFO - PROCESS | 1662 | 09:36:26 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:104.10 Median:96.00 stddev:17.76 (18.5%) stddev-sans-first:18.53 09:36:26 INFO - PROCESS | 1662 | Values: 95.0 96.0 96.0 122.0 149.0 99.0 96.0 96.0 96.0 96.0 09:36:26 INFO - PROCESS | 1662 | 09:36:26 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:86.00 stddev:1.16 (1.3%) stddev-sans-first:1.13 09:36:26 INFO - PROCESS | 1662 | Values: 84.0 84.0 86.0 86.0 86.0 87.0 86.0 84.0 86.0 84.0 09:36:26 INFO - PROCESS | 1662 | 09:36:26 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:1.03 (1.9%) stddev-sans-first:0.87 09:36:26 INFO - PROCESS | 1662 | Values: 56.0 52.0 55.0 54.0 54.0 54.0 54.0 55.0 54.0 54.0 09:36:26 INFO - PROCESS | 1662 | 09:36:26 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:71.00 stddev:4.21 (5.9%) stddev-sans-first:4.30 09:36:26 INFO - PROCESS | 1662 | Values: 68.0 65.0 72.0 81.0 74.0 72.0 70.0 70.0 70.0 70.0 09:36:26 INFO - PROCESS | 1662 | 09:36:26 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:87.00 stddev:2.45 (2.8%) stddev-sans-first:2.40 09:36:26 INFO - PROCESS | 1662 | Values: 83.0 81.0 89.0 84.0 87.0 88.0 87.0 85.0 86.0 87.0 09:36:26 INFO - PROCESS | 1662 | 09:36:26 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:149.40 Median:140.00 stddev:24.69 (17.6%) stddev-sans-first:26.19 09:36:26 INFO - PROCESS | 1662 | Values: 151.0 142.0 137.0 138.0 138.0 138.0 138.0 157.0 217.0 138.0 09:36:26 INFO - PROCESS | 1662 | 09:36:26 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.70 Median:169.00 stddev:14.54 (8.6%) stddev-sans-first:15.42 09:36:26 INFO - PROCESS | 1662 | Values: 167.0 169.0 168.0 167.0 169.0 169.0 171.0 148.0 148.0 201.0 09:36:26 INFO - PROCESS | 1662 | 09:36:26 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.70 Median:75.00 stddev:8.38 (11.2%) stddev-sans-first:8.53 09:36:26 INFO - PROCESS | 1662 | Values: 68.0 69.0 74.0 85.0 87.0 86.0 76.0 66.0 67.0 69.0 09:36:26 INFO - PROCESS | 1662 | -------- Summary: end -------- 09:36:26 INFO - PROCESS | 1662 | 09:36:27 INFO - TEST-INFO | 1662: exit 0 09:36:27 INFO - TEST-OK | kraken | took 59642ms 09:36:27 INFO - SUITE-END | took 1177s 09:36:27 INFO - Completed test suite (00:19:37) 09:36:27 INFO - javascript benchmark 09:36:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2915.4169166166766, 3352.798832070075, 3354.781939173955, 3363.4282172030753, 3393.7115345195657, 5584.1902924075985, 5656.802011929583, 5680.659160450376, 5760.4815566599, 5774.769009239625, 5647.181158731982, 5712.942870571293, 5716.542676585874, 5717.485426311631, 5726.484616384525, 5157.896842063156, 5203.739813009353, 5213.791448342062, 5242.55438287746, 5265.262863199156, 4671.944344488415, 5163.63854530183, 5364.222187782769, 5365.704886231256, 5365.946340536603, 5181.378234611833, 5348.358197016363, 5353.170258609902, 5358.410574836765, 5369.543588794957, 5138.972205558865, 5165.509276618715, 5285.7885684572575, 5299.231611416361, 5320.255164277004, 5117.1556693145585, 5134.435212126663, 5154.484551544853, 5161.096808058613, 5188.429272779991, 5656.4060773619, 5731.455511726379, 5769.24999750034, 5791.21818554494, 5805.390434004453, 6102.511799056065, 6170.228721409824, 6286.402791734778, 6287.549254133866, 6321.273053598803, 5523.972380138114, 6285.340039295854, 6302.779402720883, 6317.810465686037, 6320.146780184708, 5844.620099693549, 5856.326522449973, 5859.121131830259, 5869.618474799167, 5882.088276317178, 6227.221597300338, 6246.562740608205, 6285.465735412541, 6296.685165741695, 6304.275008374004, 6132.049532322497, 6187.102870083812, 6198.721057552421, 6206.162168107247, 6212.47193988507, 6277.591956522811, 6292.811215663537, 6295.527835412362, 6299.937000630027, 6349.746010159634, 6046.546509011841, 6164.537659675542, 6170.691465426711, 6249.468795152463, 6254.843628909222, 6230.43926046658, 6244.313125556185, 6276.372362763687, 6286.779962701375, 6305.716242769086, 5002.449730529639, 5012.924806127838, 5026.195808670595, 5036.597072234285, 5037.967216720564, 4358.978205108954, 4447.466304043535, 4488.4165058542185, 4497.955020449754, 4510.571495707903, 5644.8024319148635, 5673.6028478006965, 5728.05487094633, 5757.337906140848, 5776.55205491769, 6209.6895155242055, 6222.066689996536, 6224.751009959551, 6224.875502489925, 6246.812595622138, 5528.391876893538, 5653.406392328829, 5756.280464941882, 5764.020116580192, 5780.71096445176, 5334.333208348957, 5403.594730395236, 5406.107992181324, 5422.186671999231, 5422.864428389322, 6302.779402720883, 6305.905411418832, 6326.43062124411, 6331.27190373113, 6350.523710721622, 6216.347283535164, 6239.469645080219, 6245.125682404558, 6259.6870156492905, 6270.278917924497, 6159.84600384994, 6227.782027629011, 6272.937270627418, 6283.2774230962195, 6304.148939893055, 6201.193844800147, 6210.285817130907, 6228.813135605939, 6236.03341482071, 6236.594621349598, 6227.844303892439, 6228.346023667631, 6231.189945307262, 6234.0337247724865, 6235.688215589294, 5785.334686511105, 5969.373215812451, 6123.693815309306, 6143.477804386498, 6173.475254603409, 6142.78500252489, 6169.938300616936, 6188.845278867884, 6191.783287584913, 6203.627782333075, 5019.322391477104, 5845.620034697731, 6033.879322413615, 6033.909491357721, 6051.152838602511, 5947.9702601486715, 5979.402059793986, 6070.332263451105, 6160.199174107337, 6190.442860142609, 5890.352061273171, 5896.351401345934, 5928.436798504135, 5945.167676525203, 5953.285605727167], "value": 5708.655838434081, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [517.3248910172225, 517.8368813823644, 528.2868128027163, 529.1744877990335, 546.784020311977, 30707.539386909186, 30958.53562196566, 40094.59668911589, 41393.586064139425, 41748.58251417485, 42898.0, 43222.78388608061, 43262.567374326245, 43273.78363108188, 43326.0, 9625.518724063804, 9803.901960980405, 9812.852807207897, 9814.362066465692, 9817.803643927116, 8755.562221888911, 8965.103489651048, 11872.584459543918, 12116.575919842808, 12175.269483830998, 12041.458134383975, 12110.576129835457, 12150.39248037599, 12156.939215303912, 12160.574379896705, 8800.823983520293, 12001.579944701938, 12125.0, 12126.27242365452, 12143.817842732322, 11655.650330490014, 11947.880521194851, 11978.221415608044, 12153.878461215452, 12196.878031219663, 40641.593584064074, 40910.772676819746, 40912.0, 40955.795221023705, 40968.59031409678, 3380.1042723678247, 3392.1519620094978, 3417.0773891049525, 3438.7249020078334, 3493.458513930345, 29925.850370748223, 30598.69401305981, 30621.693783062106, 30708.232294192825, 32492.0, 3245.2049247934406, 3365.209175843675, 3385.4244778387733, 3427.605825330069, 3429.537012503305, 482430.0, 485436.99999999645, 485996.0, 486415.0, 487220.0, 57808.132878006865, 58006.129908051415, 58185.709071454374, 58198.12702809461, 58226.0, 59483.0, 59527.40472595305, 59691.403085969454, 59698.0, 59707.0, 16410.343586256415, 16643.50069497917, 16676.74984875228, 16682.666346673243, 16690.916545417196, 9949.253805964581, 11574.0, 12966.611001669966, 13030.934845325903, 13037.956963442903, 15528.456504022532, 15658.68682626341, 15864.682706345808, 15868.20658967047, 16253.268602912898, 5596.916046259309, 6388.680565971683, 6441.32366101562, 6464.191976003, 6518.674066296666, 848.8090179709516, 951.8239125761756, 991.9107280344804, 1046.4767616191905, 1086.8152414089623, 29752.0, 29980.0, 30215.244618884703, 30779.84610076935, 30823.845880770452, 985.3299756165733, 1047.7956798424234, 1138.4250953268547, 1162.7093226693328, 1182.603827717707, 12784.872151278369, 12985.35073246334, 15265.465708700141, 15631.218439078228, 16191.83808161927, 627417.0, 631775.0, 631939.0, 632207.8389608023, 633474.0, 59112.7044364784, 59598.70200649056, 59672.70163649154, 59791.70104149451, 59859.0, 1180.2092597959215, 1228.2937311046185, 1350.898682598809, 1377.9242141682303, 1388.465440805277, 30239.395212095194, 31199.660025498633, 31287.0, 31802.52296215605, 32040.198995025312, 49024.26463602977, 49422.752886235336, 49498.25752613642, 49583.760405988694, 49656.25515617341, 523361.3831930816, 526464.0, 527140.0, 527526.0, 527801.0, 22970.19604313841, 25936.61095083613, 26445.33886652849, 26448.471030579665, 39952.4007139899, 47394.52605474039, 47698.76150619225, 48459.0, 48491.515084850114, 48951.26573101335, 38646.420303694904, 39111.80444097761, 39273.60726392814, 40827.59172408357, 41136.97157571085, 38857.6114238854, 38879.028024299616, 39164.80417597894, 40358.596414036656, 40799.79600101981, 38093.047673808374, 38790.6423275184, 39078.6092139075, 39410.80294598623, 39458.0, 31031.53452698166, 33661.49507757337, 34630.82684586561, 34636.78771242994, 34745.131371714895, 21935.561288774454, 23667.763322367246, 25218.495630087662, 25393.365165871, 25823.870880645478], "value": 20190.47616014215, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.6391584709826, 372.157064249475, 376.6948771495087, 382.7760759955426, 400.21158318113305, 15272.160031198293, 16112.35550577977, 20607.896960515212, 20994.790052099514, 21042.89478552609, 18054.368097116603, 20972.700596377745, 21234.15063397466, 21330.253441129564, 21549.1380344786, 5705.74324155414, 5810.709464526778, 5839.678817665027, 6079.483243924272, 6083.391660833903, 4102.876913692594, 5842.678652674102, 5950.166976623254, 5950.940490595082, 5964.821055368346, 6213.192285002966, 6442.16251887254, 6515.250746164204, 6572.769953051644, 6601.10885030522, 5279.63042587019, 5883.52931765462, 5947.167396564484, 6544.247411547662, 6549.541532092731, 5711.7715291388295, 5749.971250143764, 5754.510866576346, 5760.596758226926, 5782.248307720011, 12379.947704445132, 16628.25172867224, 17773.0, 25671.0, 25895.870520647277, 2256.7856053674873, 2278.692376529164, 2356.646503024543, 2508.749125087495, 2692.192342297303, 9272.536373181381, 9407.670731524364, 9450.952745236298, 9738.318317717763, 9950.900490995069, 1756.7540544323806, 1820.6085691576243, 1842.3367587668429, 1902.4958386027713, 1929.7394851695121, 111798.88201117967, 116280.41859790646, 118752.0, 120071.0, 122162.0, 11231.21381503287, 11290.604828830952, 11417.48621312043, 11450.255733377304, 11631.709207269716, 14344.426222950966, 14398.784018239734, 14400.343960444683, 14401.63995900111, 14455.78316325256, 7355.963220183865, 8169.101398846122, 8352.039515455679, 8604.913950860537, 8632.136786321318, 8507.0, 8507.191816777397, 8528.848605438186, 8695.347848911231, 8725.738227853175, 4005.2990726622725, 4240.639545638655, 4383.0, 4452.154090722753, 4524.615407690318, 1595.611817718569, 1789.6689112514227, 1830.688782906909, 1838.1911958738112, 1925.5859990102194, 837.1252041616525, 855.9186877246651, 919.4942781470164, 942.7784470649392, 996.858596906538, 21062.894685526473, 21511.784882151293, 21810.672839907413, 21909.452263693536, 21948.780512194993, 721.6932803558572, 907.6188001039447, 936.9437833729862, 953.208836665566, 979.8829334558609, 10763.461826908624, 11386.202965792316, 11410.771784564262, 11485.483153258123, 11490.368029758443, 510521.0, 591765.0, 599597.0, 610570.0, 613655.0, 95415.52292238495, 107848.0, 115783.42108289404, 127255.0, 127470.36264818617, 831.1314676163303, 874.9825003499894, 952.4095061062047, 1027.6095083868083, 1027.9023492768174, 19593.179330030507, 20083.096260668597, 20317.49206269855, 20332.08505617221, 20377.0, 49649.255261171835, 54186.72906635599, 55416.72291638516, 56584.717076416004, 57909.71045144747, 77160.6141969309, 77709.0, 79373.20626793658, 79403.60298198472, 80864.19135808566, 10234.539445724811, 10501.739791225102, 12129.090318226345, 12419.130660853654, 12579.371031448574, 11429.657110286706, 12888.935555322163, 13709.245991470565, 14301.284935752963, 14393.712125757636, 10694.358338499715, 11121.83317250258, 11258.437078145897, 11700.531978720755, 11829.52681892749, 11381.943090284496, 11507.769844602893, 11599.478023488795, 11957.521699132285, 11960.222585531912, 11519.942400287944, 11603.36181510025, 12039.578614748441, 12100.334481603597, 12140.939295303468, 11966.58116965902, 12072.215306005082, 12143.574974875837, 12181.817272740738, 12405.503779849067, 11640.94179529097, 11827.526898923947, 11838.526458941546, 11939.223950443193, 12003.459844306852], "value": 9730.282147022, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1485.636019175302, 1534.6777176792873, 1675.271257003203, 1786.2140658110422, 1817.1641045119245, 8033.1565185655545, 8511.10633383495, 8526.360522960771, 8539.146085391465, 8543.06026337104, 6249.0, 7686.96156519218, 8019.157988411206, 8237.464564803284, 8320.875186872201, 2292.9541409171766, 2329.452578644017, 2331.079223706635, 2331.533693261346, 2345.6129738593113, 2288.1305104060516, 2301.827362947777, 2338.8596684199, 2339.263132113379, 2342.9765702343016, 2294.1511640692966, 2304.1820153845397, 2316.3514216019544, 2335.754745751697, 2338.9766102339013, 2293.243229734184, 2300.769923007703, 2301.873396963183, 2302.802542677798, 2304.6197377432704, 2294.954100917989, 2297.356740112771, 2301.2290882554366, 2302.251768175333, 2323.1520495019367, 8370.372222083308, 8392.244697977212, 8450.957745211295, 8465.830683386297, 8471.576421178977, 4921.704697718113, 5077.314562534048, 5079.23811428285, 5080.568151707109, 5095.668781529226, 3078.122735020531, 3102.4177669388773, 3250.333681595267, 3255.706986371238, 3265.7713960022807, 1106.8339749037627, 1109.2013750099916, 1114.804909140897, 1130.6268931252666, 1134.6936327191613, 10794.946025269823, 10847.349159050404, 10867.456627168689, 10877.67366978992, 10898.182636302308, 4283.914321713548, 4333.479982402132, 4463.799129039201, 4489.393931819162, 4515.909681806345, 9351.205147562398, 9379.108984646447, 9381.202597779129, 9420.43477391345, 9491.620335186653, 5048.848534543969, 5049.091163590516, 5053.267276244924, 5064.696118232918, 5066.797328106834, 3521.8239088046007, 4195.622393984556, 4253.914921701548, 4353.586409291112, 4626.907461850744, 3485.8605655773486, 3874.7526434667825, 3875.5079294471266, 3904.121572646132, 3929.5677475477673, 1274.1144904291427, 1276.2342594443446, 1276.8084787281796, 1297.344840855362, 1301.9088663793443, 894.4901406198404, 923.7690577355661, 932.6735642525061, 932.9207017403461, 977.880327025566, 5149.613778966593, 5534.75093620788, 5723.198752174699, 5848.883022339614, 5872.559558033079, 810.0603300171772, 905.42053086025, 967.2213867836318, 981.7300242433388, 1004.3622299839508, 3412.3857705613227, 3546.5034895114704, 3787.7348585598743, 3844.231153769257, 3975.960240397617, 9911.504424778732, 10125.291229614004, 10224.335418197794, 10309.329893556895, 10352.430616316024, 10191.694249172537, 10193.439360835226, 10200.846987295197, 10237.74405639865, 10239.692809215736, 7733.922660773433, 7856.646450909723, 7894.723684671124, 7908.051033875971, 7909.209079092045, 4024.63778259958, 5706.572007099568, 5750.194972703908, 5758.769649214152, 5773.191753154646, 9068.818623627623, 9219.953900230725, 9474.621015159317, 9573.856392153984, 9583.808323833346, 8129.674813007414, 9017.05320941318, 9364.157225849705, 9430.52847357643, 9699.224062075158, 6764.458843292623, 7905.01187351581, 7923.84152316962, 7929.603519823871, 7989.880151797612, 7870.881936771068, 7952.125266220827, 7960.880586791087, 8057.798555036171, 8120.9848768903885, 7141.85716285661, 7156.749513766993, 7194.100737407824, 7201.963990180225, 7238.782836514913, 7001.789946301619, 7042.647867606702, 7064.788056358318, 7071.575705457689, 7078.292170782881, 6694.230163531061, 6766.004028811414, 6774.0, 6782.728690852311, 6798.354156355138, 4818.759062046954, 4922.286268490977, 4940.962397896338, 4996.225585034325, 5086.18621020635, 4418.939454530953, 4476.79854406559, 4733.83431579893, 4956.752162391938, 5006.574441172395], "value": 4421.067532505144, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.59316956261233, 295.28835506429505, 304.91602353632834, 307.68616011668115, 310.964239112502, 5405.35135783706, 5443.108177652977, 5456.972715136424, 5483.643563168392, 5483.8080667176655, 4571.90856182877, 5276.630635855492, 5318.042752304584, 5326.414094449608, 5344.599155063366, 3449.637788032258, 3774.792386418746, 4064.166845796612, 4113.609207125318, 4153.563875793044, 4086.1419101988618, 4108.15782764534, 4118.878777429626, 4147.921540399503, 4216.156768646283, 3856.9971807330157, 4042.4946881639794, 4072.8981775455554, 4078.6125318094882, 4094.467719196515, 3768.453574231735, 4090.0797320602924, 4115.691323150746, 4138.627523522882, 4149.170165966819, 3536.885880947493, 3564.322778672044, 3593.729705967583, 3603.837827297778, 3623.8188090595363, 4813.796550862285, 5146.8198613048735, 5251.238570407308, 5286.867828304285, 5318.414974352818, 4409.669274804402, 4772.164871147535, 4777.63837306366, 4783.473817880031, 4791.832285869978, 5680.847129842936, 5683.658980461186, 5703.857403564903, 5709.115087161496, 5738.684372359518, 3383.627800941919, 3470.993411910543, 3491.3890069238037, 3982.422548730418, 3982.542007669097, 4862.7568621569135, 5235.743421578832, 5617.9719101404235, 5892.469677729025, 5909.763609455659, 4051.4125451809914, 4065.3738504598396, 4066.512018557733, 4080.5103387593085, 4083.2037752637953, 4089.5297040840087, 4100.630943215125, 4102.938455923164, 4104.445899803488, 4145.17096580679, 4016.9397459038137, 4038.7172897896867, 4486.026148494652, 4678.883027924261, 4767.118083154558, 4931.876703082452, 5571.9721401392735, 5700.572457065737, 5702.429757024264, 5730.570207234474, 1323.206076354199, 1387.3826147364325, 1397.9380413889635, 1418.985810141906, 1425.565202613213, 873.5675840459013, 891.4918496457087, 900.6625161634967, 952.9618815247451, 954.3224310739314, 4779.880502987453, 5206.271122042917, 5236.895262094737, 5260.28986086881, 5270.868228294246, 4975.651704380731, 5689.6586204827845, 5760.971195144081, 5770.826875193751, 5786.913196302059, 4974.403071631355, 5187.818426355059, 5189.6886186828915, 5268.868278293074, 5335.306410166653, 2529.165375426105, 2739.602757600137, 2820.3513191965963, 3057.29429454934, 3060.4032213718556, 5087.771050302746, 5960.284765828128, 6036.909446358308, 6059.272887253558, 6095.664738439428, 5112.268044327661, 5787.739551720183, 5978.730957106941, 5985.581009329305, 6029.125776762433, 4979.751012449291, 5335.466453354634, 5954.367835620268, 6009.677870868402, 6126.754929802847, 4507.481049331249, 5602.803901863415, 5783.277090363705, 5834.416558344132, 5898.083122984961, 5809.767609295581, 5817.650940943557, 5829.679367634821, 5834.103916227328, 5849.883002340014, 5278.97360513195, 5725.914111288251, 6082.36135205797, 6093.6039157454625, 6102.558976409294, 3730.589635140078, 3788.715846311593, 3844.4814298351434, 3903.8633647823326, 3965.504311961005, 5491.450854914477, 5632.662040277596, 5753.360292316837, 5782.3639399666845, 5892.705364731661, 4643.558861908114, 4650.9767451162525, 5397.487238712473, 5624.943750562442, 5681.914771278517, 4746.955669752649, 4952.380952380952, 5627.943720562742, 5692.772289108555, 5723.255976723, 5164.896702065863, 5193.870153246199, 5294.682319060868, 5397.379301380392, 5599.076152434803, 4569.794359253775, 4616.722996620214, 4683.1336202802595, 5567.10926251814, 5603.691796951207, 4614.584687378152, 4869.80689731004, 5196.818111366084, 5495.835124946258, 5584.664920104807], "value": 4131.248916662241, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.8455939693267, 730.6565914020408, 762.1121393576484, 789.1713700614354, 835.390165179419, 15003.174825384613, 15071.095734255925, 15699.0, 15722.685546289067, 15804.604884877885, 13952.860471395283, 14256.572302830931, 14290.0, 14294.428222871073, 14782.260886955635, 669.4744625469008, 693.6843736100062, 850.387720840995, 871.9215270625642, 874.807542340684, 696.1228851646911, 698.2214830464047, 698.9091418115638, 698.9336013078749, 839.5256679975824, 913.584319134792, 920.1212841736126, 925.2736601767614, 925.5372313843078, 927.9977624165919, 917.9127982841619, 918.0589895357278, 918.7106061590578, 919.3518569408551, 921.1065266691298, 524.9658772179796, 645.8514541655445, 674.9730010799611, 675.5237557521936, 677.1231255524108, 15190.392384304725, 15299.388024479007, 15299.541013769605, 15329.386824527006, 15371.385144594204, 13983.440662373594, 14335.781458576033, 14353.0, 14380.712385752331, 14408.71182576353, 12928.612141635766, 13025.934870325682, 13047.739045219138, 13216.86783132166, 13251.13867598603, 4651.88370290742, 4771.475137734847, 4784.712917224978, 4803.18345881201, 4896.951030489685, 99391.0, 100446.4799084043, 101186.49406752993, 104901.4754926228, 105015.0, 10645.78708425827, 10887.510062047228, 11008.339499630049, 11043.668689939315, 11411.315321080761, 22045.228417005328, 22120.44698882541, 22131.00410481532, 22136.335909922727, 22149.889250553966, 7637.656305466267, 7712.498687585289, 7735.961320193475, 7798.064232292161, 7860.135385107634, 3729.5151630287887, 3814.675752561008, 4374.212641724456, 4422.690411671217, 4566.840160594364, 3230.9030729078167, 3295.6374798772117, 3313.801171929692, 3314.552535407689, 3317.552130462405, 592.0586267834078, 599.9040153575407, 600.5285850607339, 615.8860610787019, 622.5579838314848, 576.9394213607595, 614.4040280927493, 622.5673157155733, 628.707650942314, 629.087822657149, 7691.923080769233, 9019.0, 9210.815783684422, 9247.815043699089, 9298.767530811649, 526.3210458508557, 540.3495852841817, 558.4387690371232, 563.2649392542771, 585.3619554685413, 3584.5698516178227, 4424.623906967944, 4442.400275962704, 4444.422225110715, 4562.24722920721, 95476.0, 124517.75482245062, 163616.3638363625, 164059.0, 164756.0, 98156.0, 121092.0, 126606.0, 128123.0, 128808.0, 72409.0, 102986.48506757418, 105058.0, 107640.46179769207, 111302.0, 8421.578921054046, 8628.180322869317, 8661.653533858575, 9251.722448326562, 9271.072892710676, 43752.0, 48478.27282590693, 55235.895282094934, 60087.0, 61153.38846611477, 64020.0, 73067.0, 73767.63116184385, 77406.22593774216, 87125.56437218026, 13311.80032299497, 13390.0, 13442.460317460318, 13446.327683615584, 13880.652983675489, 14729.116253024853, 14850.331735072165, 15069.397224110913, 15080.932880195436, 15276.465323714061, 14041.36813843359, 14087.929560352133, 14234.288285585471, 14503.85496145025, 14517.201553914636, 10794.460276985963, 13594.320283985564, 13906.0, 13910.652233694238, 14358.641033974234, 13103.2138071716, 13558.38987245596, 13590.77683008534, 13641.0, 13749.862501374859, 10995.615153469591, 11318.151138664469, 11364.772704546029, 11514.251573647685, 11621.593244236412, 11345.763540165366, 11386.94306528462, 11503.539858405904, 11559.0, 11691.064714822964], "value": 7645.854046456296, "unit": "score"}], "name": "dromaeo_css", "value": 7342.0043484278, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 113.0, 108.0, 112.0, 113.0, 113.0, 116.0, 112.0, 112.0, 112.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 104.0, 131.0, 188.0, 136.0, 138.0, 126.0, 107.0, 177.0, 137.0], "value": 138.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 186.0, 182.0, 182.0, 197.0, 237.0, 243.0, 262.0, 184.0], "value": 204.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 148.0, 60.0, 81.0, 86.0, 129.0, 93.0, 58.0], "value": 87.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 90.0, 137.0, 70.0, 72.0, 70.0, 117.0, 71.0, 69.0, 119.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 92.0, 88.0, 90.0, 87.0, 91.0, 89.0, 91.0, 87.0], "value": 89.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 122.0, 149.0, 99.0, 96.0, 96.0, 96.0, 96.0], "value": 104.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 86.0, 86.0, 86.0, 87.0, 86.0, 84.0, 86.0, 84.0], "value": 85.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 52.0, 55.0, 54.0, 54.0, 54.0, 54.0, 55.0, 54.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 72.0, 81.0, 74.0, 72.0, 70.0, 70.0, 70.0, 70.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 89.0, 84.0, 87.0, 88.0, 87.0, 85.0, 86.0, 87.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 142.0, 137.0, 138.0, 138.0, 138.0, 138.0, 157.0, 217.0, 138.0], "value": 149.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 169.0, 168.0, 167.0, 169.0, 169.0, 171.0, 148.0, 148.0, 201.0], "value": 167.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 74.0, 85.0, 87.0, 86.0, 76.0, 66.0, 67.0, 69.0], "value": 74.7, "unit": "score"}], "name": "kraken", "value": 1513.2000000000003, "alertThreshold": 2.0}]} 09:36:27 INFO - Return code: 0 09:36:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:36:27 INFO - # TBPL SUCCESS # 09:36:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:36:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:36:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:36:27 INFO - 2016-08-22 09:36:27.959 screenresolution[1666:9690] starting screenresolution argv=screenresolution get 09:36:27 INFO - 2016-08-22 09:36:27.962 screenresolution[1666:9690] Display 0: 1600x1200x32@60 09:36:27 INFO - 2016-08-22 09:36:27.968 screenresolution[1667:9693] starting screenresolution argv=screenresolution list 09:36:27 INFO - Available Modes on Display 0 09:36:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:36:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:36:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:36:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:36:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:36:28 INFO - Intel Iris: 09:36:28 INFO - Chipset Model: Intel Iris 09:36:28 INFO - Type: GPU 09:36:28 INFO - Bus: Built-In 09:36:28 INFO - VRAM (Dynamic, Max): 1536 MB 09:36:28 INFO - Vendor: Intel (0x8086) 09:36:28 INFO - Device ID: 0x0a2e 09:36:28 INFO - Revision ID: 0x0009 09:36:28 INFO - Displays: 09:36:28 INFO - Display: 09:36:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:36:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:36:28 INFO - Display Serial Number: 1600x1200 60 09:36:28 INFO - Main Display: Yes 09:36:28 INFO - Mirror: Off 09:36:28 INFO - Online: Yes 09:36:28 INFO - Rotation: Supported 09:36:28 INFO - Return code: 0 09:36:28 INFO - Running post-action listener: _resource_record_post_action 09:36:28 INFO - [mozharness: 2016-08-22 16:36:28.211315Z] Finished run-tests step (success) 09:36:28 INFO - Running post-run listener: _resource_record_post_run 09:36:28 INFO - Total resource usage - Wall time: 1213s; CPU: 53.0%; Read bytes: 37262336; Write bytes: 706344960; Read time: 240; Write time: 1995 09:36:28 INFO - TinderboxPrint: CPU usage
53.4% 09:36:28 INFO - TinderboxPrint: I/O read bytes / time
37,262,336 / 240 09:36:28 INFO - TinderboxPrint: I/O write bytes / time
706,344,960 / 1,995 09:36:28 INFO - TinderboxPrint: CPU idle
2,261.9 (46.6%) 09:36:28 INFO - TinderboxPrint: CPU system
971.8 (20.0%) 09:36:28 INFO - TinderboxPrint: CPU user
1,620.0 (33.4%) 09:36:28 INFO - TinderboxPrint: Swap in / out
443,883,520 / 0 09:36:28 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 385298944; Write bytes: 379389440; Read time: 29011; Write time: 797 09:36:28 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 36291584; Write bytes: 297226752; Read time: 226; Write time: 1127 09:36:28 INFO - Running post-run listener: _upload_blobber_files 09:36:28 INFO - Blob upload gear active. 09:36:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:36:28 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 09:36:28 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:36:28 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:36:29 INFO - (blobuploader) - INFO - Open directory for files ... 09:36:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:36:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:36:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:30 INFO - (blobuploader) - INFO - Done attempting. 09:36:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:36:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:36:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:31 INFO - (blobuploader) - INFO - Done attempting. 09:36:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:36:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:36:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:33 INFO - (blobuploader) - INFO - Done attempting. 09:36:33 INFO - (blobuploader) - INFO - Iteration through files over. 09:36:33 INFO - Return code: 0 09:36:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:36:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:36:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33b7b89bf4c656dc60ef3fc5eed0edf375745999528f5bfa68253b25b1c76e061ce08ca8cd3a9df47f01d45ff174d921e29af6e65059534816e2b31792fc2c44", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1bc33aa4d03cf5cdd9b354ba4507f8efc28fd43070ff2d7bfeb8b45e2dd3e3986408576731640f8e57f41fa10fc010bf6dc0fbc73f59d7e0dfde7a5281dcd40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87488177f1fdd99f8f38270bbaa633898b26dc7a747c06fe910c44e0850d6ba1536fd66e2e3f7f562477a7f86a60415cabc214cffe90397aa1d4fbd6161d0288"} 09:36:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:36:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:36:33 INFO - Contents: 09:36:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33b7b89bf4c656dc60ef3fc5eed0edf375745999528f5bfa68253b25b1c76e061ce08ca8cd3a9df47f01d45ff174d921e29af6e65059534816e2b31792fc2c44", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1bc33aa4d03cf5cdd9b354ba4507f8efc28fd43070ff2d7bfeb8b45e2dd3e3986408576731640f8e57f41fa10fc010bf6dc0fbc73f59d7e0dfde7a5281dcd40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87488177f1fdd99f8f38270bbaa633898b26dc7a747c06fe910c44e0850d6ba1536fd66e2e3f7f562477a7f86a60415cabc214cffe90397aa1d4fbd6161d0288"} 09:36:33 INFO - Running post-run listener: copy_logs_to_upload_dir 09:36:33 INFO - Copying logs to upload dir... 09:36:33 INFO - mkdir: /builds/slave/test/build/upload/logs 09:36:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.299562 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-22 09:36:33.616010) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 09:36:33.620132) ========= 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.bkAtUQgLyl/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.eAgWcA4mGg/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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/Firefox/sha512/33b7b89bf4c656dc60ef3fc5eed0edf375745999528f5bfa68253b25b1c76e061ce08ca8cd3a9df47f01d45ff174d921e29af6e65059534816e2b31792fc2c44", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1bc33aa4d03cf5cdd9b354ba4507f8efc28fd43070ff2d7bfeb8b45e2dd3e3986408576731640f8e57f41fa10fc010bf6dc0fbc73f59d7e0dfde7a5281dcd40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87488177f1fdd99f8f38270bbaa633898b26dc7a747c06fe910c44e0850d6ba1536fd66e2e3f7f562477a7f86a60415cabc214cffe90397aa1d4fbd6161d0288"} build_url:https://queue.taskcluster.net/v1/task/JINZnX9qTQuZ9Lu-BOmtJg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010805 build_url: 'https://queue.taskcluster.net/v1/task/JINZnX9qTQuZ9Lu-BOmtJg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33b7b89bf4c656dc60ef3fc5eed0edf375745999528f5bfa68253b25b1c76e061ce08ca8cd3a9df47f01d45ff174d921e29af6e65059534816e2b31792fc2c44", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1bc33aa4d03cf5cdd9b354ba4507f8efc28fd43070ff2d7bfeb8b45e2dd3e3986408576731640f8e57f41fa10fc010bf6dc0fbc73f59d7e0dfde7a5281dcd40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87488177f1fdd99f8f38270bbaa633898b26dc7a747c06fe910c44e0850d6ba1536fd66e2e3f7f562477a7f86a60415cabc214cffe90397aa1d4fbd6161d0288"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 09:36:33.652731) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:36:33.653063) ========= 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.bkAtUQgLyl/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.eAgWcA4mGg/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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.005123 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:36:33.701302) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 09:36:33.701630) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 09:36:33.701920) ========= ========= Total master_lag: 0.17 =========