builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0133 starttime: 1494193991.05 results: success (0) buildid: 20170507135942 builduid: 64eb17a83b3a4a508c8068778967707b revision: e767c39dad3a388a9014ef6dbbaa708c31b71279 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-07 14:53:11.053495) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-07 14:53:11.054354) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-07 14:53:11.054676) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-07 14:53:11.084024) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 14:53:11.085384) ========= 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.3S1I5GRCFM/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.h2A9H6CthY/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 --2017-05-07 14:53:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.7M=0.001s 2017-05-07 14:53:11 (13.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.175505 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 14:53:11.300443) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 14:53:11.300764) ========= 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.3S1I5GRCFM/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.h2A9H6CthY/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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.023061 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 14:53:11.351922) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-07 14:53:11.352296) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e767c39dad3a388a9014ef6dbbaa708c31b71279 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e767c39dad3a388a9014ef6dbbaa708c31b71279 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3S1I5GRCFM/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.h2A9H6CthY/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 2017-05-07 14:53:11,431 truncating revision to first 12 chars 2017-05-07 14:53:11,431 Setting DEBUG logging. 2017-05-07 14:53:11,431 attempt 1/10 2017-05-07 14:53:11,432 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e767c39dad3a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-07 14:53:13,042 unpacking tar archive at: mozilla-beta-e767c39dad3a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.864770 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-07 14:53:13.245516) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-07 14:53:13.246276) ========= script_repo_revision: e767c39dad3a388a9014ef6dbbaa708c31b71279 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-07 14:53:13.246879) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-07 14:53:13.247212) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-07 14:53:13.268203) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-05-07 14:53:13.268545) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3S1I5GRCFM/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.h2A9H6CthY/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 14:53:13 INFO - MultiFileLogger online at 20170507 14:53:13 in /builds/slave/test 14:53:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:53:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:53:13 INFO - {'append_to_log': False, 14:53:13 INFO - 'base_work_dir': '/builds/slave/test', 14:53:13 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:53:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:53:13 INFO - 'branch': 'Mozilla-Beta', 14:53:13 INFO - 'buildbot_json_path': 'buildprops.json', 14:53:13 INFO - 'config_files': ('talos/mac_config.py',), 14:53:13 INFO - 'default_actions': ('clobber', 14:53:13 INFO - 'read-buildbot-config', 14:53:13 INFO - 'download-and-extract', 14:53:13 INFO - 'populate-webroot', 14:53:13 INFO - 'create-virtualenv', 14:53:13 INFO - 'install', 14:53:13 INFO - 'run-tests'), 14:53:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:53:13 INFO - 'download_minidump_stackwalk': True, 14:53:13 INFO - 'download_symbols': 'ondemand', 14:53:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:53:13 INFO - 'tooltool.py': '/tools/tooltool.py', 14:53:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:53:13 INFO - '/tools/misc-python/virtualenv.py')}, 14:53:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:53:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:53:13 INFO - 'gecko_profile': False, 14:53:13 INFO - 'gecko_profile_interval': 0, 14:53:13 INFO - 'installer_path': 'installer.exe', 14:53:13 INFO - 'log_level': 'info', 14:53:13 INFO - 'log_name': 'talos', 14:53:13 INFO - 'log_to_console': True, 14:53:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:53:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:53:13 INFO - 'opt_config_files': (), 14:53:13 INFO - 'pip_index': False, 14:53:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:53:13 INFO - 'cmd': ('bash', 14:53:13 INFO - '-c', 14:53:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:53:13 INFO - 'enabled': True, 14:53:13 INFO - 'halt_on_failure': False, 14:53:13 INFO - 'name': 'check_screen_resolution'},), 14:53:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:53:13 INFO - 'cmd': ('bash', 14:53:13 INFO - '-c', 14:53:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:53:13 INFO - 'enabled': True, 14:53:13 INFO - 'halt_on_failure': False, 14:53:13 INFO - 'name': 'check_screen_resolution'},), 14:53:13 INFO - 'run_cmd_checks_enabled': True, 14:53:13 INFO - 'suite': 'dromaeojs-e10s', 14:53:13 INFO - 'system_bits': '32', 14:53:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:53:13 INFO - 'title': 't-yosemite-r7-0133', 14:53:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:53:13 INFO - 'use_talos_json': True, 14:53:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:53:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:53:13 INFO - 'work_dir': 'build'} 14:53:13 INFO - [mozharness: 2017-05-07 21:53:13.479525Z] Running clobber step. 14:53:13 INFO - Running pre-action listener: _resource_record_pre_action 14:53:13 INFO - Running main action method: clobber 14:53:13 INFO - rmtree: /builds/slave/test/build 14:53:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:53:15 INFO - Running post-action listener: _resource_record_post_action 14:53:15 INFO - [mozharness: 2017-05-07 21:53:15.291060Z] Finished clobber step (success) 14:53:15 INFO - [mozharness: 2017-05-07 21:53:15.291310Z] Running read-buildbot-config step. 14:53:15 INFO - Running pre-action listener: _resource_record_pre_action 14:53:15 INFO - Running main action method: read_buildbot_config 14:53:15 INFO - Using buildbot properties: 14:53:15 INFO - { 14:53:15 INFO - "project": "", 14:53:15 INFO - "product": "firefox", 14:53:15 INFO - "script_repo_revision": "production", 14:53:15 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 14:53:15 INFO - "repository": "", 14:53:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 14:53:15 INFO - "buildid": "20170507135942", 14:53:15 INFO - "pgo_build": "False", 14:53:15 INFO - "basedir": "/builds/slave/test", 14:53:15 INFO - "buildnumber": 26, 14:53:15 INFO - "slavename": "t-yosemite-r7-0133", 14:53:15 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 14:53:15 INFO - "platform": "yosemite_r7", 14:53:15 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:53:15 INFO - "branch": "mozilla-beta", 14:53:15 INFO - "repo_path": "releases/mozilla-beta", 14:53:15 INFO - "revision": "e767c39dad3a388a9014ef6dbbaa708c31b71279", 14:53:15 INFO - "stage_platform": "macosx64", 14:53:15 INFO - "builduid": "64eb17a83b3a4a508c8068778967707b", 14:53:15 INFO - "slavebuilddir": "test" 14:53:15 INFO - } 14:53:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 14:53:15 INFO - Running post-action listener: _resource_record_post_action 14:53:15 INFO - [mozharness: 2017-05-07 21:53:15.297186Z] Finished read-buildbot-config step (success) 14:53:15 INFO - [mozharness: 2017-05-07 21:53:15.297414Z] Running download-and-extract step. 14:53:15 INFO - Running pre-action listener: _resource_record_pre_action 14:53:15 INFO - Running main action method: download_and_extract 14:53:15 INFO - mkdir: /builds/slave/test/build/tests 14:53:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:15 INFO - trying https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 14:53:15 INFO - Downloading https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 14:53:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 14:53:16 INFO - Downloaded 1287 bytes. 14:53:16 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 14:53:16 INFO - Using the following test package requirements: 14:53:16 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:53:16 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 14:53:16 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 14:53:16 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:53:16 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 14:53:16 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:53:16 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 14:53:16 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:53:16 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:53:16 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 14:53:16 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 14:53:16 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:53:16 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 14:53:16 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:53:16 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 14:53:16 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:53:16 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 14:53:16 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:53:16 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 14:53:16 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 14:53:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 14:53:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 14:53:16 INFO - Fetch https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 14:53:18 INFO - Expected file size: 51226373 14:53:18 INFO - Obtained file size: 51226373 14:53:34 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 14:53:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 14:53:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 14:53:34 INFO - Fetch https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 14:53:35 INFO - Expected file size: 51226373 14:53:35 INFO - Obtained file size: 51226373 14:53:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 14:53:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 14:53:50 INFO - Fetch https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 14:53:52 INFO - Expected file size: 14404449 14:53:52 INFO - Obtained file size: 14404449 14:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:52 INFO - trying https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.dmg 14:53:52 INFO - Downloading https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 14:53:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 14:53:54 INFO - Downloaded 59565746 bytes. 14:53:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.dmg 14:53:54 INFO - mkdir: /builds/slave/test/properties 14:53:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:53:54 INFO - Writing to file /builds/slave/test/properties/build_url 14:53:54 INFO - Contents: 14:53:54 INFO - build_url:https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.dmg 14:53:54 INFO - Running post-action listener: _resource_record_post_action 14:53:54 INFO - Running post-action listener: set_extra_try_arguments 14:53:54 INFO - [mozharness: 2017-05-07 21:53:54.840905Z] Finished download-and-extract step (success) 14:53:54 INFO - [mozharness: 2017-05-07 21:53:54.841020Z] Running populate-webroot step. 14:53:54 INFO - Running pre-action listener: _resource_record_pre_action 14:53:54 INFO - Running main action method: populate_webroot 14:53:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:53:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:53:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:53:54 INFO - '--tppagecycles', 14:53:54 INFO - '7'], 14:53:54 INFO - 'tests': ['tsvgm']}}, 14:53:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:53:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:53:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:53:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:53:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:53:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:53:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:53:54 INFO - 'talos_options': ['--disable-e10s'], 14:53:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:53:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:53:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:53:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:53:54 INFO - 'talos_options': ['--disable-e10s'], 14:53:54 INFO - 'tests': ['damp', 'tps']}, 14:53:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:53:54 INFO - 'tests': ['damp', 'tps']}, 14:53:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:53:54 INFO - 'tests': ['dromaeo_dom']}, 14:53:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:53:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:53:54 INFO - 'tests': ['basic_compositor_video']}, 14:53:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:53:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:53:54 INFO - 'tests': ['a11yr', 14:53:54 INFO - 'ts_paint', 14:53:54 INFO - 'tpaint', 14:53:54 INFO - 'sessionrestore', 14:53:54 INFO - 'sessionrestore_no_auto_restore', 14:53:54 INFO - 'tabpaint']}, 14:53:54 INFO - 'other-e10s': {'tests': ['a11yr', 14:53:54 INFO - 'ts_paint', 14:53:54 INFO - 'tpaint', 14:53:54 INFO - 'sessionrestore', 14:53:54 INFO - 'sessionrestore_no_auto_restore', 14:53:54 INFO - 'tabpaint']}, 14:53:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:53:54 INFO - 'ts_paint', 14:53:54 INFO - 'tpaint', 14:53:54 INFO - 'sessionrestore', 14:53:54 INFO - 'sessionrestore_no_auto_restore', 14:53:54 INFO - 'tabpaint']}, 14:53:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:53:54 INFO - 'ts_paint', 14:53:54 INFO - 'tpaint', 14:53:54 INFO - 'sessionrestore', 14:53:54 INFO - 'sessionrestore_no_auto_restore', 14:53:54 INFO - 'tabpaint']}, 14:53:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:53:54 INFO - 'tests': ['a11yr', 14:53:54 INFO - 'ts_paint', 14:53:54 INFO - 'tpaint', 14:53:54 INFO - 'sessionrestore', 14:53:54 INFO - 'sessionrestore_no_auto_restore', 14:53:54 INFO - 'tabpaint']}, 14:53:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:53:54 INFO - 'tests': ['a11yr', 14:53:54 INFO - 'ts_paint', 14:53:54 INFO - 'tpaint', 14:53:54 INFO - 'sessionrestore', 14:53:54 INFO - 'sessionrestore_no_auto_restore', 14:53:54 INFO - 'tabpaint']}, 14:53:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:53:54 INFO - 'tests': ['tsvgx', 14:53:54 INFO - 'tsvgr_opacity', 14:53:54 INFO - 'tart', 14:53:54 INFO - 'tscrollx', 14:53:54 INFO - 'cart', 14:53:54 INFO - 'tsvg_static']}, 14:53:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:53:54 INFO - 'tsvgr_opacity', 14:53:54 INFO - 'tart', 14:53:54 INFO - 'tscrollx', 14:53:54 INFO - 'cart', 14:53:54 INFO - 'tsvg_static']}, 14:53:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:53:54 INFO - 'talos_options': ['--disable-e10s'], 14:53:54 INFO - 'tests': ['tp5o']}, 14:53:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:53:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:53:54 INFO - 'talos_options': ['--disable-e10s', 14:53:54 INFO - '--xperf_path', 14:53:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:53:54 INFO - 'tests': ['tp5n']}, 14:53:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:53:54 INFO - 'talos_options': ['--xperf_path', 14:53:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:53:54 INFO - 'tests': ['tp5n']}}, 14:53:54 INFO - 'talos.zip': {'path': '', 14:53:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:53:54 INFO - Running post-action listener: _resource_record_post_action 14:53:54 INFO - [mozharness: 2017-05-07 21:53:54.859227Z] Finished populate-webroot step (success) 14:53:54 INFO - [mozharness: 2017-05-07 21:53:54.859361Z] Running create-virtualenv step. 14:53:54 INFO - Running pre-action listener: _resource_record_pre_action 14:53:54 INFO - Running main action method: create_virtualenv 14:53:54 INFO - Creating virtualenv /builds/slave/test/build/venv 14:53:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:53:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:53:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:53:54 INFO - Using real prefix '/tools/python27' 14:53:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:53:55 INFO - Installing distribute.............................................................................................................................................................................................done. 14:53:58 INFO - Installing pip.................done. 14:53:58 INFO - Return code: 0 14:53:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:53:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:53:58 INFO - Reading from file tmpfile_stdout 14:53:58 INFO - Output received: 14:53:58 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:53:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:58 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 0x10c168b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c16b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5e2576400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf46d30>, '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 0x10be6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf3bbe8>, '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.3S1I5GRCFM/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.h2A9H6CthY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:53:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:53:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:53:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3S1I5GRCFM/Render', 14:53:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:53:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:53:58 INFO - 'HOME': '/Users/cltbld', 14:53:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:53:58 INFO - 'LOGNAME': 'cltbld', 14:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:58 INFO - 'MOZ_NO_REMOTE': '1', 14:53:58 INFO - 'NO_EM_RESTART': '1', 14:53:58 INFO - 'PAGER': '/bin/cat', 14:53:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:58 INFO - 'PWD': '/builds/slave/test', 14:53:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:53:58 INFO - 'SHELL': '/bin/bash', 14:53:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h2A9H6CthY/Listeners', 14:53:58 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 14:53:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:53:58 INFO - 'USER': 'cltbld', 14:53:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:53:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:58 INFO - 'XPC_FLAGS': '0x0', 14:53:58 INFO - 'XPC_SERVICE_NAME': '0', 14:53:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:53:59 INFO - Cleaning up... 14:53:59 INFO - Return code: 0 14:53:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53: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', '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 0x10c168b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c16b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5e2576400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf46d30>, '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 0x10be6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf3bbe8>, '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.3S1I5GRCFM/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.h2A9H6CthY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:53: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', 'psutil>=3.1.1'] in /builds/slave/test/build 14:53: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 psutil>=3.1.1 14:53:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3S1I5GRCFM/Render', 14:53:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:53:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:53:59 INFO - 'HOME': '/Users/cltbld', 14:53:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:53:59 INFO - 'LOGNAME': 'cltbld', 14:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:59 INFO - 'MOZ_NO_REMOTE': '1', 14:53:59 INFO - 'NO_EM_RESTART': '1', 14:53:59 INFO - 'PAGER': '/bin/cat', 14:53:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:59 INFO - 'PWD': '/builds/slave/test', 14:53:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:53:59 INFO - 'SHELL': '/bin/bash', 14:53:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h2A9H6CthY/Listeners', 14:53:59 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 14:53:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:53:59 INFO - 'USER': 'cltbld', 14:53:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:53:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:59 INFO - 'XPC_FLAGS': '0x0', 14:53:59 INFO - 'XPC_SERVICE_NAME': '0', 14:53:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:59 INFO - Downloading/unpacking psutil>=3.1.1 14:53: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 14:53: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 14:53: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 14:53: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 14:53: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 14:53: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 14:54:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:54:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:54:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:54:01 INFO - Installing collected packages: psutil 14:54:01 INFO - Running setup.py install for psutil 14:54:02 INFO - building 'psutil._psutil_osx' extension 14:54:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:54:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:54:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:54:02 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:54:02 INFO - building 'psutil._psutil_posix' extension 14:54:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:54:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:54:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:54:02 INFO - ^ 14:54:02 INFO - 1 warning generated. 14:54:02 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:54:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:54:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:54:02 INFO - Successfully installed psutil 14:54:02 INFO - Cleaning up... 14:54:02 INFO - Return code: 0 14:54:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:02 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 0x10c168b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c16b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5e2576400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf46d30>, '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 0x10be6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf3bbe8>, '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.3S1I5GRCFM/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.h2A9H6CthY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:54:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:54:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:54:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3S1I5GRCFM/Render', 14:54:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:54:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:54:02 INFO - 'HOME': '/Users/cltbld', 14:54:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:54:02 INFO - 'LOGNAME': 'cltbld', 14:54:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:02 INFO - 'MOZ_NO_REMOTE': '1', 14:54:02 INFO - 'NO_EM_RESTART': '1', 14:54:02 INFO - 'PAGER': '/bin/cat', 14:54:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:54:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:02 INFO - 'PWD': '/builds/slave/test', 14:54:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:54:02 INFO - 'SHELL': '/bin/bash', 14:54:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h2A9H6CthY/Listeners', 14:54:02 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 14:54:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:54:02 INFO - 'USER': 'cltbld', 14:54:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:54:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:54:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:02 INFO - 'XPC_FLAGS': '0x0', 14:54:02 INFO - 'XPC_SERVICE_NAME': '0', 14:54:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:54:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:54:04 INFO - Installing collected packages: mozsystemmonitor 14:54:04 INFO - Running setup.py install for mozsystemmonitor 14:54:04 INFO - Successfully installed mozsystemmonitor 14:54:04 INFO - Cleaning up... 14:54:04 INFO - Return code: 0 14:54:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:54:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:04 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 0x10c168b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c16b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5e2576400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf46d30>, '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 0x10be6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf3bbe8>, '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.3S1I5GRCFM/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.h2A9H6CthY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:54:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:54:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:54:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3S1I5GRCFM/Render', 14:54:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:54:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:54:04 INFO - 'HOME': '/Users/cltbld', 14:54:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:54:04 INFO - 'LOGNAME': 'cltbld', 14:54:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:04 INFO - 'MOZ_NO_REMOTE': '1', 14:54:04 INFO - 'NO_EM_RESTART': '1', 14:54:04 INFO - 'PAGER': '/bin/cat', 14:54:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:54:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:04 INFO - 'PWD': '/builds/slave/test', 14:54:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:54:04 INFO - 'SHELL': '/bin/bash', 14:54:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h2A9H6CthY/Listeners', 14:54:04 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 14:54:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:54:04 INFO - 'USER': 'cltbld', 14:54:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:54:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:54:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:04 INFO - 'XPC_FLAGS': '0x0', 14:54:04 INFO - 'XPC_SERVICE_NAME': '0', 14:54:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:54:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:05 INFO - Downloading/unpacking jsonschema==2.5.1 14:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:54:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:06 INFO - Downloading functools32-3.2.3-2.tar.gz 14:54:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:54:06 INFO - warning: no files found matching '*.txt' 14:54:06 INFO - no previously-included directories found matching 'build' 14:54:06 INFO - no previously-included directories found matching 'dist' 14:54:06 INFO - no previously-included directories found matching '.git*' 14:54:06 INFO - Installing collected packages: jsonschema, functools32 14:54:06 INFO - Running setup.py install for functools32 14:54:06 INFO - warning: no files found matching '*.txt' 14:54:06 INFO - no previously-included directories found matching 'build' 14:54:06 INFO - no previously-included directories found matching 'dist' 14:54:06 INFO - no previously-included directories found matching '.git*' 14:54:06 INFO - Successfully installed jsonschema functools32 14:54:06 INFO - Cleaning up... 14:54:06 INFO - Return code: 0 14:54:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c168b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c16b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5e2576400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf46d30>, '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 0x10be6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf3bbe8>, '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.3S1I5GRCFM/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.h2A9H6CthY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:54:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:54:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:54:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3S1I5GRCFM/Render', 14:54:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:54:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:54:06 INFO - 'HOME': '/Users/cltbld', 14:54:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:54:06 INFO - 'LOGNAME': 'cltbld', 14:54:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:06 INFO - 'MOZ_NO_REMOTE': '1', 14:54:06 INFO - 'NO_EM_RESTART': '1', 14:54:06 INFO - 'PAGER': '/bin/cat', 14:54:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:54:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:06 INFO - 'PWD': '/builds/slave/test', 14:54:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:54:06 INFO - 'SHELL': '/bin/bash', 14:54:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h2A9H6CthY/Listeners', 14:54:06 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 14:54:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:54:06 INFO - 'USER': 'cltbld', 14:54:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:54:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:54:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:06 INFO - 'XPC_FLAGS': '0x0', 14:54:06 INFO - 'XPC_SERVICE_NAME': '0', 14:54:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:54:07 INFO - Cleaning up... 14:54:07 INFO - Return code: 0 14:54:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:07 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 0x10c168b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c16b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5e2576400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf46d30>, '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 0x10be6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf3bbe8>, '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.3S1I5GRCFM/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.h2A9H6CthY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:54:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:54:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:54:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3S1I5GRCFM/Render', 14:54:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:54:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:54:07 INFO - 'HOME': '/Users/cltbld', 14:54:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:54:07 INFO - 'LOGNAME': 'cltbld', 14:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:07 INFO - 'MOZ_NO_REMOTE': '1', 14:54:07 INFO - 'NO_EM_RESTART': '1', 14:54:07 INFO - 'PAGER': '/bin/cat', 14:54:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:07 INFO - 'PWD': '/builds/slave/test', 14:54:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:54:07 INFO - 'SHELL': '/bin/bash', 14:54:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h2A9H6CthY/Listeners', 14:54:07 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 14:54:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:54:07 INFO - 'USER': 'cltbld', 14:54:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:54:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:07 INFO - 'XPC_FLAGS': '0x0', 14:54:07 INFO - 'XPC_SERVICE_NAME': '0', 14:54:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:07 INFO - Downloading/unpacking blobuploader==1.2.4 14:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:08 INFO - Downloading blobuploader-1.2.4.tar.gz 14:54:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:54:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:54:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:09 INFO - Downloading docopt-0.6.1.tar.gz 14:54:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:54:09 INFO - Installing collected packages: blobuploader, requests, docopt 14:54:09 INFO - Running setup.py install for blobuploader 14:54:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:54:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:54:10 INFO - Running setup.py install for requests 14:54:10 INFO - Running setup.py install for docopt 14:54:10 INFO - Successfully installed blobuploader requests docopt 14:54:10 INFO - Cleaning up... 14:54:10 INFO - Return code: 0 14:54:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:54:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:10 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 0x10c168b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c16b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5e2576400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf46d30>, '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 0x10be6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf3bbe8>, '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.3S1I5GRCFM/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.h2A9H6CthY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:54:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:54:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:54:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3S1I5GRCFM/Render', 14:54:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:54:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:54:10 INFO - 'HOME': '/Users/cltbld', 14:54:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:54:10 INFO - 'LOGNAME': 'cltbld', 14:54:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:10 INFO - 'MOZ_NO_REMOTE': '1', 14:54:10 INFO - 'NO_EM_RESTART': '1', 14:54:10 INFO - 'PAGER': '/bin/cat', 14:54:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:54:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:10 INFO - 'PWD': '/builds/slave/test', 14:54:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:54:10 INFO - 'SHELL': '/bin/bash', 14:54:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h2A9H6CthY/Listeners', 14:54:10 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 14:54:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:54:10 INFO - 'USER': 'cltbld', 14:54:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:54:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:54:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:10 INFO - 'XPC_FLAGS': '0x0', 14:54:10 INFO - 'XPC_SERVICE_NAME': '0', 14:54:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:54:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:54:11 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-TYeaeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:54:11 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-YXwGUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:54:11 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-nX4FRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:54:11 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-od1L4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:54:11 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-rFjwzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:54:11 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-jbIpxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:54:11 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-2Hnphy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:54:11 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-X_DsEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:54:11 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-cFFg87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:54:11 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-0kJHaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:54:12 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-OtJ9un-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:54:12 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-gOj4BC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:54:12 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-2BWAbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:54:12 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-g77Q8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:12 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-LCN2n3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:54:12 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-EhZGaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:54:12 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-wvXZ7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:54:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:54:12 INFO - Running setup.py install for manifestparser 14:54:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:54:12 INFO - Running setup.py install for mozcrash 14:54:13 INFO - Running setup.py install for mozdebug 14:54:13 INFO - Running setup.py install for mozdevice 14:54:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:54:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:54:13 INFO - Running setup.py install for mozfile 14:54:13 INFO - Running setup.py install for mozhttpd 14:54:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:54:13 INFO - Running setup.py install for mozinfo 14:54:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:54:13 INFO - Running setup.py install for mozInstall 14:54:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:54:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:54:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:54:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:54:14 INFO - Running setup.py install for mozleak 14:54:14 INFO - Running setup.py install for mozlog 14:54:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:54:14 INFO - Running setup.py install for moznetwork 14:54:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:54:14 INFO - Running setup.py install for mozprocess 14:54:14 INFO - Running setup.py install for mozprofile 14:54:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:54:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:54:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:54:14 INFO - Running setup.py install for mozrunner 14:54:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:54:14 INFO - Running setup.py install for mozscreenshot 14:54:15 INFO - Running setup.py install for moztest 14:54:15 INFO - Running setup.py install for mozversion 14:54:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:54:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:54:15 INFO - Cleaning up... 14:54:15 INFO - Return code: 0 14:54:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:54:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:15 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 0x10c168b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c16b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5e2576400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf46d30>, '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 0x10be6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf3bbe8>, '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.3S1I5GRCFM/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.h2A9H6CthY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:54:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:54:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:54:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3S1I5GRCFM/Render', 14:54:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:54:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:54:15 INFO - 'HOME': '/Users/cltbld', 14:54:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:54:15 INFO - 'LOGNAME': 'cltbld', 14:54:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:15 INFO - 'MOZ_NO_REMOTE': '1', 14:54:15 INFO - 'NO_EM_RESTART': '1', 14:54:15 INFO - 'PAGER': '/bin/cat', 14:54:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:54:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:15 INFO - 'PWD': '/builds/slave/test', 14:54:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:54:15 INFO - 'SHELL': '/bin/bash', 14:54:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h2A9H6CthY/Listeners', 14:54:15 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 14:54:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:54:15 INFO - 'USER': 'cltbld', 14:54:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:54:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:54:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:15 INFO - 'XPC_FLAGS': '0x0', 14:54:15 INFO - 'XPC_SERVICE_NAME': '0', 14:54:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:54:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:54:15 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-biksdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:54:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:54:15 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-GjXbyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:54:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:54:15 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-DO8GAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:54:16 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-ZZV5vA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:54:16 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-UAAZUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:54:16 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-G5qxsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:54:16 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-RrG4nr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:54:16 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-woV1IK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:54:16 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-GisrPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:54:16 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-zGMN84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:54:16 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-mCDSQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:54:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:54:16 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-AZQ7GW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:54:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:54:17 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-JmRXEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:54:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:54:17 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-0I8TL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:54:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:17 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-3tZKcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:54:17 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-ebb8QH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:54:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:54:17 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-xvq6FH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:54:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:54:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:54:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:54:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:54:17 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:54:17 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:54:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:18 INFO - Downloading blessings-1.6.tar.gz 14:54:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:54:18 INFO - Installing collected packages: blessings 14:54:18 INFO - Running setup.py install for blessings 14:54:19 INFO - Successfully installed blessings 14:54:19 INFO - Cleaning up... 14:54:19 INFO - Return code: 0 14:54:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:54:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:54:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:54:19 INFO - Reading from file tmpfile_stdout 14:54:19 INFO - Current package versions: 14:54:19 INFO - blessings == 1.6 14:54:19 INFO - blobuploader == 1.2.4 14:54:19 INFO - docopt == 0.6.1 14:54:19 INFO - functools32 == 3.2.3-2 14:54:19 INFO - jsonschema == 2.5.1 14:54:19 INFO - manifestparser == 1.1 14:54:19 INFO - mozInstall == 1.12 14:54:19 INFO - mozcrash == 1.0 14:54:19 INFO - mozdebug == 0.1 14:54:19 INFO - mozdevice == 0.49 14:54:19 INFO - mozfile == 1.2 14:54:19 INFO - mozhttpd == 0.7 14:54:19 INFO - mozinfo == 0.9 14:54:19 INFO - mozleak == 0.1 14:54:19 INFO - mozlog == 3.4 14:54:19 INFO - moznetwork == 0.27 14:54:19 INFO - mozprocess == 0.25 14:54:19 INFO - mozprofile == 0.28 14:54:19 INFO - mozrunner == 6.13 14:54:19 INFO - mozscreenshot == 0.1 14:54:19 INFO - mozsystemmonitor == 0.3 14:54:19 INFO - moztest == 0.8 14:54:19 INFO - mozversion == 1.4 14:54:19 INFO - psutil == 3.1.1 14:54:19 INFO - requests == 1.2.3 14:54:19 INFO - wsgiref == 0.1.2 14:54:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:19 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 0x10c168b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c16b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5e2576400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf46d30>, '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 0x10be6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf3bbe8>, '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.3S1I5GRCFM/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.h2A9H6CthY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:54:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:54:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:54:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3S1I5GRCFM/Render', 14:54:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:54:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:54:19 INFO - 'HOME': '/Users/cltbld', 14:54:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:54:19 INFO - 'LOGNAME': 'cltbld', 14:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:19 INFO - 'MOZ_NO_REMOTE': '1', 14:54:19 INFO - 'NO_EM_RESTART': '1', 14:54:19 INFO - 'PAGER': '/bin/cat', 14:54:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:19 INFO - 'PWD': '/builds/slave/test', 14:54:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:54:19 INFO - 'SHELL': '/bin/bash', 14:54:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h2A9H6CthY/Listeners', 14:54:19 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 14:54:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:54:19 INFO - 'USER': 'cltbld', 14:54:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:54:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:19 INFO - 'XPC_FLAGS': '0x0', 14:54:19 INFO - 'XPC_SERVICE_NAME': '0', 14:54:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:54:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:54:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:54:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:54:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:54:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:54:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:54:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:54:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:54:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:54:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:54:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:54:19 INFO - Cleaning up... 14:54:19 INFO - Return code: 0 14:54:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:19 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 0x10c168b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c16b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5e2576400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf46d30>, '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 0x10be6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf3bbe8>, '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.3S1I5GRCFM/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.h2A9H6CthY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:54:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:54:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:54:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3S1I5GRCFM/Render', 14:54:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:54:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:54:19 INFO - 'HOME': '/Users/cltbld', 14:54:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:54:19 INFO - 'LOGNAME': 'cltbld', 14:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:19 INFO - 'MOZ_NO_REMOTE': '1', 14:54:19 INFO - 'NO_EM_RESTART': '1', 14:54:19 INFO - 'PAGER': '/bin/cat', 14:54:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:19 INFO - 'PWD': '/builds/slave/test', 14:54:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:54:19 INFO - 'SHELL': '/bin/bash', 14:54:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h2A9H6CthY/Listeners', 14:54:19 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 14:54:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:54:19 INFO - 'USER': 'cltbld', 14:54:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:54:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:19 INFO - 'XPC_FLAGS': '0x0', 14:54:19 INFO - 'XPC_SERVICE_NAME': '0', 14:54:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:54:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:54:20 INFO - Cleaning up... 14:54:20 INFO - Return code: 0 14:54:20 INFO - Running post-action listener: _resource_record_post_action 14:54:20 INFO - Running post-action listener: _start_resource_monitoring 14:54:20 INFO - Starting resource monitoring. 14:54:20 INFO - [mozharness: 2017-05-07 21:54:20.067374Z] Finished create-virtualenv step (success) 14:54:20 INFO - [mozharness: 2017-05-07 21:54:20.068441Z] Running install step. 14:54:20 INFO - Running pre-action listener: _resource_record_pre_action 14:54:20 INFO - Running main action method: install 14:54:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:54:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:54:20 INFO - Reading from file tmpfile_stdout 14:54:20 INFO - Detecting whether we're running mozinstall >=1.0... 14:54:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:54:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:54:20 INFO - Reading from file tmpfile_stdout 14:54:20 INFO - Output received: 14:54:20 INFO - Usage: mozinstall [options] installer 14:54:20 INFO - Options: 14:54:20 INFO - -h, --help show this help message and exit 14:54:20 INFO - -d DEST, --destination=DEST 14:54:20 INFO - Directory to install application into. [default: 14:54:20 INFO - "/builds/slave/test"] 14:54:20 INFO - --app=APP Application being installed. [default: firefox] 14:54:20 INFO - mkdir: /builds/slave/test/build/application 14:54:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:54:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 14:54:35 INFO - Reading from file tmpfile_stdout 14:54:35 INFO - Output received: 14:54:35 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:54:35 INFO - Running post-action listener: _resource_record_post_action 14:54:35 INFO - [mozharness: 2017-05-07 21:54:35.090531Z] Finished install step (success) 14:54:35 INFO - [mozharness: 2017-05-07 21:54:35.090674Z] Running run-tests step. 14:54:35 INFO - Running pre-action listener: _resource_record_pre_action 14:54:35 INFO - Running main action method: run_tests 14:54:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:54:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:54:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:54:35 INFO - 2017-05-07 14:54:35.104 screenresolution[3783:71858] starting screenresolution argv=screenresolution get 14:54:35 INFO - 2017-05-07 14:54:35.106 screenresolution[3783:71858] Display 0: 1600x1200x32@60 14:54:35 INFO - 2017-05-07 14:54:35.112 screenresolution[3784:71861] starting screenresolution argv=screenresolution list 14:54:35 INFO - Available Modes on Display 0 14:54:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:54:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:54:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:54:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:54:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:54:35 INFO - Intel Iris: 14:54:35 INFO - Chipset Model: Intel Iris 14:54:35 INFO - Type: GPU 14:54:35 INFO - Bus: Built-In 14:54:35 INFO - VRAM (Dynamic, Max): 1536 MB 14:54:35 INFO - Vendor: Intel (0x8086) 14:54:35 INFO - Device ID: 0x0a2e 14:54:35 INFO - Revision ID: 0x0009 14:54:35 INFO - Displays: 14:54:35 INFO - Display: 14:54:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:54:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:54:35 INFO - Display Serial Number: 1600x1200 60 14:54:35 INFO - Main Display: Yes 14:54:35 INFO - Mirror: Off 14:54:35 INFO - Online: Yes 14:54:35 INFO - Rotation: Supported 14:54:35 INFO - Return code: 0 14:54:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:54:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:54:35 INFO - Python 2.7.3 14:54:35 INFO - Return code: 0 14:54:35 INFO - grabbing minidump binary from tooltool 14:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:35 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 0x10bf46d30>, '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 0x10be6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf3bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:54:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:54:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:54:35 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:54:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:54:35 INFO - Return code: 0 14:54:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:54:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:54:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:54:35 INFO - ENV: RUST_BACKTRACE is now 1 14:54:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:54:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:54:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0133', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:54:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0133 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:54:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3S1I5GRCFM/Render', 14:54:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:54:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:54:35 INFO - 'HOME': '/Users/cltbld', 14:54:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:54:35 INFO - 'LOGNAME': 'cltbld', 14:54:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:54:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:54:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:35 INFO - 'MOZ_NO_REMOTE': '1', 14:54:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:54:35 INFO - 'NO_EM_RESTART': '1', 14:54:35 INFO - 'PAGER': '/bin/cat', 14:54:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:54:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:35 INFO - 'PWD': '/builds/slave/test', 14:54:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:54:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:54:35 INFO - 'RUST_BACKTRACE': '1', 14:54:35 INFO - 'SHELL': '/bin/bash', 14:54:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.h2A9H6CthY/Listeners', 14:54:35 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 14:54:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:54:35 INFO - 'USER': 'cltbld', 14:54:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:54:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:54:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:35 INFO - 'XPC_FLAGS': '0x0', 14:54:35 INFO - 'XPC_SERVICE_NAME': '0', 14:54:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:54:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0133', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:54:35 INFO - mozversion application_buildid: 20170507135942 14:54:35 INFO - mozversion application_changeset: e767c39dad3a388a9014ef6dbbaa708c31b71279 14:54:35 INFO - mozversion application_display_name: Firefox 14:54:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:54:35 INFO - mozversion application_name: Firefox 14:54:35 INFO - mozversion application_remotingname: firefox 14:54:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:54:35 INFO - mozversion application_vendor: Mozilla 14:54:35 INFO - mozversion application_version: 54.0 14:54:35 INFO - mozversion platform_buildid: 20170507135942 14:54:35 INFO - mozversion platform_changeset: e767c39dad3a388a9014ef6dbbaa708c31b71279 14:54:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:54:35 INFO - mozversion platform_version: 54.0 14:54:35 INFO - using testdate: 1494194075 14:54:35 INFO - actual date: 1494194075 14:54:35 INFO - starting webserver on 'localhost:53543' 14:54:35 INFO - SUITE-START | Running 2 tests 14:54:35 INFO - TEST-START | dromaeo_css 14:54:35 INFO - operating with platform_type : mac_ 14:54:35 INFO - Initialising browser for dromaeo_css test... 14:54:35 INFO - TEST-INFO | started process 3794 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/tmp5mKmaM/profile http://localhost:53543/getInfo.html) 14:54:38 INFO - PROCESS | 3794 | 2017-05-07 14:54:38.608 plugin-container[3797:72016] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b3f, name = 'com.apple.tsm.portname' 14:54:38 INFO - PROCESS | 3794 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:54:38 INFO - PROCESS | 3794 | 2017-05-07 14:54:38.608 plugin-container[3797:72016] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 14:54:38 INFO - PROCESS | 3794 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:54:38 INFO - PROCESS | 3794 | 2017-05-07 14:54:38.608 plugin-container[3797:72016] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:54:38 INFO - PROCESS | 3794 | __metrics Screen width/height:1600/1200 14:54:38 INFO - PROCESS | 3794 | colorDepth:24 14:54:38 INFO - PROCESS | 3794 | Browser inner width/height: 1024/689 14:54:38 INFO - PROCESS | 3794 | __metrics 14:54:38 ERROR - PROCESS | 3794 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 14:54:39 INFO - TEST-INFO | 3794: exit 0 14:54:39 INFO - Browser initialized. 14:54:39 INFO - Running cycle 1/1 for dromaeo_css test... 14:54:39 INFO - TEST-INFO | started process 3798 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/tmp5mKmaM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:54:41 INFO - PROCESS | 3798 | 2017-05-07 14:54:41.967 plugin-container[3799:72148] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x894b, name = 'com.apple.tsm.portname' 14:54:41 INFO - PROCESS | 3798 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:54:41 INFO - PROCESS | 3798 | 2017-05-07 14:54:41.967 plugin-container[3799:72148] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 14:54:41 INFO - PROCESS | 3798 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:54:41 INFO - PROCESS | 3798 | 2017-05-07 14:54:41.967 plugin-container[3799:72148] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:54:51 INFO - PROCESS | 3798 | RSS: Main: 174297088 14:54:51 INFO - PROCESS | 3798 | 14:57:53 INFO - PROCESS | 3798 | Cycle 1(1): loaded http://localhost:53543/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53543/tests/dromaeo/cssquery-ext.html) 14:57:55 INFO - PROCESS | 3798 | RSS: Main: 189345792 14:57:55 INFO - PROCESS | 3798 | 15:00:58 INFO - PROCESS | 3798 | Cycle 1(1): loaded http://localhost:53543/tests/dromaeo/cssquery-ext.html (next: http://localhost:53543/tests/dromaeo/cssquery-jquery.html) 15:00:58 INFO - PROCESS | 3798 | RSS: Main: 203943936 15:00:58 INFO - PROCESS | 3798 | 15:04:00 INFO - PROCESS | 3798 | Cycle 1(1): loaded http://localhost:53543/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53543/tests/dromaeo/cssquery-mootools.html) 15:04:01 INFO - PROCESS | 3798 | RSS: Main: 205529088 15:04:01 INFO - PROCESS | 3798 | 15:07:03 INFO - PROCESS | 3798 | Cycle 1(1): loaded http://localhost:53543/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53543/tests/dromaeo/cssquery-prototype.html) 15:07:03 INFO - PROCESS | 3798 | RSS: Main: 208592896 15:07:03 INFO - PROCESS | 3798 | 15:10:06 INFO - PROCESS | 3798 | Cycle 1(1): loaded http://localhost:53543/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53543/tests/dromaeo/cssquery-yui.html) 15:10:07 INFO - PROCESS | 3798 | RSS: Main: 211062784 15:10:07 INFO - PROCESS | 3798 | 15:13:10 INFO - PROCESS | 3798 | Cycle 1(1): loaded http://localhost:53543/tests/dromaeo/cssquery-yui.html (next: http://localhost:53543/tests/dromaeo/cssquery-dojo.html) 15:13:10 INFO - PROCESS | 3798 | RSS: Main: 209207296 15:13:10 INFO - PROCESS | 3798 | 15:13:10 INFO - PROCESS | 3798 | __start_tp_report 15:13:10 INFO - PROCESS | 3798 | _x_x_mozilla_page_load 15:13:10 INFO - PROCESS | 3798 | _x_x_mozilla_page_load_details 15:13:10 INFO - PROCESS | 3798 | |i|pagename|runs| 15:13:10 INFO - PROCESS | 3798 | |0;dojo.html;3500.614932357442;3523.453864650979;3550.92898142037;3560.0921764949944;3560.2523470071283;6035.818925432233;6062.242219722535;6067.726952287141;6129.417705317987;6144.477719393857;6042.879142417149;6123.601965872226;6131.3562075982045;6157.091301696466;6181.258249010125;4790.712557246559;5275.654708049442;5468.7539060742165;5506.80726174584;5534.916976245359;5559.694216818073;5590.692511911843;5593.496585307322;5595.440455954393;5624.072028115356;4030.45588845505;4542.273236282195;5390.865228369303;5543.196236545698;5606.775728970836;5486.451354864522;5513.724313784335;5575.721213939287;5607.411221821691;5625.774969001235;5385.353757549119;5500.944990550123;5516.7517461714315;5533.6403133796175;5565.777368905239;5928.466438020556;6141.723622437001;6151.569390142692;6160.5687601867885;6179.258488981306;6325.652089135096;6334.968325158345;6347.238331400262;6357.745690172387;6374.266959299647;5534.584906132056;6563.851326017928;6614.206295244601;6646.069550262967;6660.500462465335;6227.813165605039;6231.127642130105;6244.438000579969;6247.375262473762;6252.874942501125;6429.517786166056;6440.323766004596;6625.536212465081;6665.766698165541;6669.7665581704405;6415.422611964946;6438.25960014595;6464.321246269074;6508.088867558546;6510.414062734377;5534.225208470737;6569.441597464269;6645.269020407752;6683.6658167091455;6709.228438729609;6225.128482012522;6253.624782513064;6346.809595712136;6563.638999855054;6569.408753212234;6508.056331831953;6539.280679125292;6555.311692272338;6556;6560.475161987029;5228.6339956203465;5230.241614965808;5257.737113144328;5262.578993680497;5285.233641122016;4553.749543775058;4579.5878370946775;4666.357438191733;4695.812167513262;4739.810407583727;6196.194494715748;6212.751489940442;6257.812265632038;6261.405166509175;6292.244930608356;6597.703103360361;6650.268470468244;6651.201855777338;6658.1011563438315;6661.566998145105;6102.298235702862;6118.4668989547035;6122.611623597813;6248.000319948877;6284.842878927972;5718.370979192286;5736.598438109292;5742.885142297214;5756.079027355603;5773.960687076283;6814.863702725818;6826.931730682828;6841.247462779091;6876.656167191721;6891.931080689229;6269.686515674107;6668.833279167866;6683.598984060972;6687.732490700318;6693.26374098839;6617.867642647217;6707.698153583198;6715.5299129060495;6736.393724564813;6758.357955994173;6515.706793194412;6526.477881769542;6534.313897040743;6535.771248006297;6543.836404089936;6570.113034740249;6586.868262634624;6612.140421745143;6623.205215374186;6624.171978502687;6206.441420272197;6225.657588832658;6251.312355640966;6260.467860231931;6266.028765541349;6240.188775459162;6376.202974628171;6381.904271436025;6419.871602567829;6444.355564443518;6127.417895299939;6198.721057552511;6217.067439884054;6277.2153480814895;6281.71732272058;6185.072239163981;6236.812895613139;6258;6280.905786413116;6406.487481001415;5198.766055527435;6238.532110091671;6255.280642726145;6288.339724328879;6306.432421082125 15:13:10 INFO - PROCESS | 3798 | |1;ext.html;731.8792399254123;734.5115498193702;757.1406453675081;993.5280741647714;997.242096007034;39355.606443935554;40413;41520.37719434211;41586.960325991866;41615;30895;36723;37200.255994880084;38500.61499385005;38507.22985540295;7982.481138725993;8561.630139177732;9259.81480370394;9411.152996230338;9419.152276295132;8766.298696104297;9482.004389539103;9485.762855928588;9499.857502137473;9516.381435206724;8044.276015158634;9441.10309520598;9504;9520.143187113159;9521.190698790577;9446.905530944672;9463;9475.952620236923;9482.810343793086;9513.47675877823;9280.628774848998;9330.906690933072;9339.859902101474;9348.158665720119;9351.50375939853;30088.79644814205;35923.4611480828;35935.82032089849;36130.819345903365;36256.45615315746;3796.487474191004;3932.744371615836;3942.8817135485983;3951.3480275754464;3995.98002009991;26391.604125938127;26482.73517264822;27058.729412706016;27260.59109113365;27636.30909227265;3219.7263232625255;3260.608726952757;3264.9836750816094;3286;3312.569365982431;255951;349905;353315.2334238338;355616;358163.4183658156;44556.88607784767;44871.653850384544;45080.74596270173;45194;45203.54796452059;47091.529084708716;47159;47163.349282774936;47213;47419.577412677674;14279.500217492337;14344;14419.639509012359;14455.204963726886;14470.421183152766;12256.81614775779;12339.814902776465;12591.496340146292;12611.558595449298;12614.81077783834;9124.498152601538;9901.950490247647;10492.580296788043;10544.367337959748;10575.36547807134;4759.6668233223345;4800.687955282965;4804;4814.133455977888;4819.542033562908;1140.7547377313917;1170.7599942011866;1178.7524619829933;1184.283508477376;1224.9877501225053;23062;26857.462850743268;27631.171064868086;27639.30901727473;27869.72130278712;1082.7617924056694;1085.8968398002178;1143.6969203161168;1226.5093962415106;1283.9535778340623;13883.722325553634;14230.573082807532;14383.51414276527;14468.855311446961;14558.563243102724;407224;407986;408346;408565.9571702182;412004;56250.59373515695;56320.43679563152;56327;56349.15476267859;56476.717616412476;1496.8203815541988;1536.9538913832603;1548.6592949551307;1551.5655616427418;1561.203786069113;25527.872360638077;26667.733322666525;26994.730052699222;27119.1864244073;27172;46492;46705.76647116878;46711.59865203913;46785.29822052604;46807.76596116998;371786;375642;377269;377273;377755;28046.85976570104;28559.000434984675;31736.36527269488;32149.839250803598;32966;44194;45543.77228113838;45670.54329456663;46334.768326158155;46946.53053469422;30156.69843301539;31539.423028848007;31577;31829.681703182672;31978.680213198502;31636.080901922793;31958.84020579882;32199.67800321967;32230;32420.675793241764;37209.4418583716;37799.05502362463;38055.858324250315;38149.664761733206;38252;30953.8452307746;31954.881579144618;32116.03651890447;32312.83843580767;32458.701651933658;22174.667379989634;22664.433389165402;24481.75518244795;25477.006726569212;25756.742432575433 15:13:10 INFO - PROCESS | 3798 | |2;jquery.html;414.5377903637443;429.24024476676306;429.58545004071067;437.8226818138654;442.8959194589271;21107.366778996635;22112;22196.556068878614;23275.767242327613;23508.412289692766;22503.324900252977;22785.772142278573;23202.76797232027;23487.412814679643;23624.645630315557;6929.722811087563;7205.423566114724;7220.530665506752;7732.072151341847;8070.435069545134;7652.31129198372;8140.43016988811;8176.46852954559;8197.549134797584;8214.589270536479;8086.231807978233;8086.433949623529;8121.553314567696;8144.552049637267;8151.266386025257;7767.9611601941915;7891.013623297088;7916.366690664762;7953.681852725884;7976.282134607855;7291.869760187179;7293.963530182368;7534.54792712439;7766.922330776676;7907.762767116996;26413.603795943076;27017.594736078976;27113.05104321359;27141.1857644271;27543.898244070213;2904.2739315171207;3005.5792189093545;3074.569560261565;3088.799228050192;3093.02569690549;15985.680286394207;16071.874968752192;16162.838371616368;16188.595285117848;16973.405930792364;2093.72781538399;2149.3659370485743;2152.612529744645;2154.353693891826;2163.2104281937136;135107.999999999;138700;169806;174653.1267343668;174972.1251393735;20380.694289585666;21422.357329280145;21490.78509214919;21708.240211592518;21712.022958966885;33014.3397132056;33301;33356.99929002134;33357.499637505454;33454.99635010953;9101.362904596615;10711.946440267904;10982.780344393068;11149.219554631098;11192.04867586248;9224.7693807654;9251.49116798569;9269.980302166756;9274.165325120772;9393.859092113624;9839.409635421898;9891.455969921579;9919.256055795844;9981.301308908307;9982.450965196838;4306.354046892991;4394.1870753910625;4412.139632771643;4421.7789110544345;4429.2027435062;889.3330002498126;899.1188635137602;951.4538874329215;1049.960539066319;1118.8209886418297;22256.443588910406;22506.21228257003;22601.547969040526;22658.433539161324;22796.886015569817;910.9933523456485;1095.901368876805;1125.7241975715838;1135.7785231879704;1135.8750537440874;9672.032796720272;11033.668989930315;11711.1802173847;11729.589464368706;11735.706607334885;658714;689607;690947.5452622805;694216;728378;160426.19786900992;160516;162519;163604.36395635892;170146;1092.317301686446;1218.707510197564;1315.4803852478217;1316.82881225442;1334.4061892457762;19835.504112397306;20034.198632055137;20248.08883600212;20390.796092039483;20539.281125161146;44015;57391;62508;63181.68409157925;63761.68119159374;71328.57342853218;88640.11359886319;90315.5484222601;91586.62620060571;91956.54021729849;11108.389038602954;11483.483243253906;11521.695660868028;11597.478113485082;11678.532858685558;12398.194117382342;12637.304948227937;12819.807702884278;12939.935300323814;13053.804192937303;11099.001089901947;11114.999650031536;11189.083820662703;11268.267562608404;11292.774144517229;10257.128144107834;10349.741256468347;10603.840942386025;10690.57237710514;10710.303830251009;6447.580907241015;8633.96392432912;11176.385298808644;11373.715657108307;11444.484998174936;11324.94337528307;11477.196596238184;11554.133439992202;11682.824757628812;11686.532538698357;10080.747981300527;10172.08451239392;11005.889941100806;11014.39420831862;11265.042471389695 15:13:10 INFO - PROCESS | 3798 | |3;mootools.html;1418.7659036259017;1546.5746919597113;1605.759136129581;1640.3766568703884;1640.401253542457;10953.45232738363;11663.650090497287;11695;11748.236364636292;12148.635540933765;9675;11461.968422841943;11622.767544649101;11742.706432339195;11765.882241187095;2447.0211915233917;2494.950100997979;2495.2264797912703;2495.625656151574;2499.8875050622673;2416.7220769611454;2441.0967941861536;2473.3940184654784;2474.5298393305306;2492.277239600514;1987.9503012424732;2366.4675448024227;2382.4877651304964;2474.443250268693;2482;1961.7155512450686;2360.221127028077;2400.0879665726998;2405.9639105413435;2444.2300675287406;2422.9757702422926;2457.6313552967017;2457.913973010936;2461.0155937624913;2463.3102731235103;11260.831087533694;11561.30632162073;11600.187986840925;11656.242344247681;11727.17909746318;5819.621724587931;5931.940680593225;5967.283925928917;5971.343152253248;5987.461128498456;3633;3643.6902863256655;3677.5770786359644;3736.7197460190323;3775.9433608495897;1264.6089301768075;1267.5690265309838;1277.9108934958542;1304.3413076396455;1318.057588823986;12391.814122788166;12642.735726427376;13210.471581136742;13985.58043258704;16235;4724.394038730669;4726.645501587394;4803;4837.975810120927;4845.49122342149;12254.693632659077;12263.69340766488;12276.38618069093;12277.38613069343;12347;5941.851453713692;5991.370906054802;6017.939820601826;6025.8192254232445;6031.457168854824;5363.517283444508;5380.461953804588;5436.510714035756;5462.044142275086;5524.226608274845;3651.1054791575702;3758.605346438639;4072.735272207297;4093.97953010239;4119.505659320841;1050.6900464363032;1050.9264351495322;1053.5733028123623;1060.0406631998055;1063.7606538528769;971.5482300730054;990.7721224118493;998.8801343838786;1012.8480727890728;1020.8213562626511;6898.517103802786;6966.268541803139;6990.047645837663;7009.859802803915;7140.285971402922;1070.6531975850864;1084.1760262200785;1096.6161843354762;1109.611635927419;1115.2973626615342;4262.552431994658;4298.20483210607;4308.138372325548;4666.136764698542;4748.738819364969;14013.789793153112;14397.42410303576;14407.855921440861;14445;14460.927695361666;14100.576982690536;14168.149911005372;14228.644283892778;14310.642233944234;14389.568312950629;9953.303268771262;10154.796904061877;10178.745531361626;10201.948990255001;10229.641962531276;6247.9062814056915;6930.306969303029;7063;7210.351068403869;7299.963500182465;9567.330286879851;12279.69300767488;12825;12829.61511154667;12832.486700532249;11252.324860508395;11460.255083419552;12940.870591293966;13141;13189.868101319247;9462.337636365388;9477.431354118775;9497.14525692691;9596.136347728738;9597.952010239904;10429.06138447513;10549.52527136296;10638.73403164927;10652.520636571218;10698.144148467949;7559.622018899143;9069.138431848964;9077.228435582785;9102.726918192464;9122.133397327243;8842.513661748666;8909.688160914337;8954.507502087448;9147.954260228656;9169.633214671338;8076.555789431638;8082.15137410587;8112.756617301255;8114.472559283628;8149.266566009088;5962.105684147413;5989.940100598938;6013.6692481913915;6195.070739389128;6199.3490683477585;6010.42900924429;6173.228346456693;6217.813465596039;6236.781712640036;6304.306526282197 15:13:10 INFO - PROCESS | 3798 | |4;prototype.html;362.46355394016854;383.93665045267534;397.92163237626033;403.18355330455825;407.6758976613592;4541.591256786888;5156.92264616031;5262.763175657095;5415.729213539322;5571.832845014651;4503.819847206116;5246.7901283948595;5255.923910055535;5268.710220937856;5320.308359913206;3576.856925722968;4379.321205213181;4425.933610995838;4461.174682683698;4461.442319710036;3599.5860476045195;4389.310115605499;4414.410812107639;4439.400680908068;4474.440694913136;4093.6461534617565;4335.479742430913;4344.261475549164;4351.434313539251;4396.076823866992;4208.179405016023;4346.78266086696;4352.891177720567;4380.7152535085115;4413.403076492648;3625.800580968046;4016.2971479990883;4081.2041651877894;4097.975506123469;4138.8344466221315;4188.81150348235;4274.29474136767;4315.697901146921;4962.429320628138;5015.921576860956;4569.177548041352;4766.594839438617;5050.04049230645;5072.467390923974;5141.948580514222;4940.654154209206;5084.983003399335;5143.7685304161405;5632.239647647556;5680.630759000693;3463.809490478023;3779.6031416701126;4526.502084770673;4557.020240648277;4588.334691469719;5289.418164001957;5389.556547886624;5588.944110558924;5593.608447408683;5889.882202355929;3845.384738441892;3984.9800750996637;4119.855805046809;4343.370211319341;4425.402570652985;4427.07422271313;4579.900823802263;4678.649101317346;4690.1088793129875;4720.150372932905;4193.958060419357;4517.299818528133;4765.760902165462;4921.8523444296725;4924.655274130777;4868.318435419044;4887.804487820447;4942.456329803718;5246.383182799113;5751.424857514216;1343.9798403023963;1358.3955139962623;1525.7787620794923;1612.0247250413565;1627.8128015278157;1104.0615476844778;1141.8801025892328;1212.8908398244023;1218.65268398506;1225.3873063468266;4719.811207551728;4913.606911447076;5100.928804950928;5392.595555333287;5448.863778405493;5505.9724701376235;5833;5834.970825145847;5893.642542982841;5894.229712035337;4752.910608104759;4962.146765609788;5134.178531434953;5446.509814116748;5497.257870187474;2676.531606968773;2769.9197313047925;2933.574631678395;3030.8028328809996;3087.644920834133;5170.45710200431;5320.068987927098;5343.545798607084;5414.756335964891;6077.058056001327;5267.604929630293;5654.46282603152;5960.4072228579835;5997.910031349533;6065.363136870653;5221.973890130525;5716.828495145152;6111.96944015277;6129.724162412791;6151.5386346024225;4791.945771930309;5588.764494202352;5611.270534830446;5861.677607731445;5930.377310382521;5430.348358197041;5729.54163666914;5778.393268706725;5797.681127538026;5800;5038.470960549236;5146.536811686966;5935.486450954979;6076.473027594294;6107.114468402146;4159.667226621924;4367.5414081520985;4556.430446194226;4580.999445363293;4596.770161491979;5175.404828444777;5282.260483532232;5578.414266502121;5764.308283006066;5785.119836053384;4851.417829860439;5113.795448182031;5720.685362305113;5723.914141287967;5757.942420575908;4998.375203099613;5653.660780353192;5666.575006874418;5683.403242659461;5761.48146666802;5217.791288348423;5233.528982391603;5581.74882130297;5589.6802826826415;5666.546676265972;4961.652684312064;5637.267155269953;5820.272465941757;5820.73806678692;5891.558133140117;4429.601335879786;5122.641415100908;5369.785208591613;5731.627444216113;5753.964286428483 15:13:10 INFO - PROCESS | 3798 | |5;yui.html;742.0946445336688;742.5878637356268;769.2730369800538;800.7477644541968;912.7854954085791;14169.858301416984;15880.444184453547;16966.830331696678;17281.70387220957;17502.29990800368;15607.609809754762;16035.438759643415;16156.676866462692;16282.94160879542;16292.42976495823;999.7650552120245;1026.5072765072769;1027.3784360461925;1027.9794404111913;1028.598846449885;801.9037715474151;1010.5301035018715;1022.3508072374021;1034.3173505486382;1035.3011717090972;1071.791000754853;1076.2573824061374;1076.6716151573767;1078.6116997880756;1080.5461706083424;1063.1813503602261;1068.551208492435;1071.1109778883508;1074.156786922266;1075.5643964194476;782.6438970268514;792.1800936031237;793.5278509286965;795.9562224077673;796.2674339607574;16866.662666746597;16955.406560770312;16983.57541061471;17786.110694465355;17964.101794910333;14356.497522586764;14620.70758584833;14703.117812931258;14814;14977.925110374379;11706.531738730526;11757.35334556599;11936;11997.700057498545;12116.515339386415;3748.0629842539365;3817.503724515795;3859.6333348331864;3884.126071633888;4024.818883150236;111489.99999999919;113011.43494282558;114850;116466;116794;10930.344179349264;11108.333499990027;11155.442227888736;11286.54853805855;11312.264702794291;22157.335279941628;22205.000774965167;22304.88847555752;22325.888370558045;22341.441463963532;7450.18048014718;7516.962415187889;7596.5946299934685;7610.467267291237;7636.274553917369;4468.955310446854;4541.386912766734;4541.841035563805;4570.245909424974;4605.585497305258;3532.6643968822923;3576.2668652926086;3598.442241452579;3617.0957260684827;3636.254567813592;659.1398225315913;665.7569986954727;670.4401824476519;679.9728010879609;682.5802131689074;498.27003439959907;667.864630128783;682.3279070115932;687.226869771507;687.7695971849387;9366.29752768545;10169.9491502542;10551.788964220827;10629.202809789296;10904.890951090387;476.4354240225344;548.5364866687643;561.4525837308673;587.4477990688739;757.8938948547208;5192.740362981911;5316.946830531722;5359.490848369399;5360.624756267024;5404.91892621611;104488;106885;107662;108104;110832.33751493735;86887.1311286879;89035;92313;93898.53050734839;94765.052349477;79442.60278698569;81545.77681334785;81687.59156204181;82556.58721706473;82870.75693864597;8061.87907181381;8682.392232543662;10180.541875615467;10250.384976901112;10295.794084118126;45266.54733452755;45735;45862.541374585824;46825.2976205364;47299.29051064168;51882.481175187764;57498;59847.80304393975;64095.359046410806;64794.02808957964;12907.483700651868;13099.67250818699;13137.934310328386;13197.20816750998;13701.314934253447;15223.847761522686;15277.508030178176;15493.380264789283;15736.685266294839;16172.514824555283;14053.929730351283;14280.167650602207;14413.495527656902;14463.783043254149;14961.775573366625;13947.232902190071;14176.220307883166;14348.784768228275;14487;14888.851111489179;13551.72896542044;13683.589492315246;14266.785998209827;14350.995430320196;14838.629034274229;8864;10249.231307651808;10569.524371403151;10709;10762.946185269024;10784.352938823695;11373.21061353256;11784.019341551544;11848.940755296167;11912.523499060288 15:13:10 INFO - PROCESS | 3798 | __end_tp_report 15:13:10 INFO - PROCESS | 3798 | __start_cc_report 15:13:10 INFO - PROCESS | 3798 | _x_x_mozilla_cycle_collect,391 15:13:10 INFO - PROCESS | 3798 | __end_cc_report 15:13:10 INFO - PROCESS | 3798 | __startTimestamp1494195190819__endTimestamp 15:13:10 INFO - PROCESS | 3798 | 15:13:10 INFO - PROCESS | 3798 | ------- Summary: start ------- 15:13:10 INFO - PROCESS | 3798 | Number of tests: 6 15:13:10 INFO - PROCESS | 3798 | 15:13:10 INFO - PROCESS | 3798 | [#0] dojo.html Cycles:165 Average:6042.93 Median:6248.00 stddev:703.87 (11.3%) stddev-sans-first:677.18 15:13:10 INFO - PROCESS | 3798 | Values: 3500.6 3523.5 3550.9 3560.1 3560.3 6035.8 6062.2 6067.7 6129.4 6144.5 6042.9 6123.6 6131.4 6157.1 6181.3 4790.7 5275.7 5468.8 5506.8 5534.9 5559.7 5590.7 5593.5 5595.4 5624.1 4030.5 4542.3 5390.9 5543.2 5606.8 5486.5 5513.7 5575.7 5607.4 5625.8 5385.4 5500.9 5516.8 5533.6 5565.8 5928.5 6141.7 6151.6 6160.6 6179.3 6325.7 6335.0 6347.2 6357.7 6374.3 5534.6 6563.9 6614.2 6646.1 6660.5 6227.8 6231.1 6244.4 6247.4 6252.9 6429.5 6440.3 6625.5 6665.8 6669.8 6415.4 6438.3 6464.3 6508.1 6510.4 5534.2 6569.4 6645.3 6683.7 6709.2 6225.1 6253.6 6346.8 6563.6 6569.4 6508.1 6539.3 6555.3 6556.0 6560.5 5228.6 5230.2 5257.7 5262.6 5285.2 4553.7 4579.6 4666.4 4695.8 4739.8 6196.2 6212.8 6257.8 6261.4 6292.2 6597.7 6650.3 6651.2 6658.1 6661.6 6102.3 6118.5 6122.6 6248.0 6284.8 5718.4 5736.6 5742.9 5756.1 5774.0 6814.9 6826.9 6841.2 6876.7 6891.9 6269.7 6668.8 6683.6 6687.7 6693.3 6617.9 6707.7 6715.5 6736.4 6758.4 6515.7 6526.5 6534.3 6535.8 6543.8 6570.1 6586.9 6612.1 6623.2 6624.2 6206.4 6225.7 6251.3 6260.5 6266.0 6240.2 6376.2 6381.9 6419.9 6444.4 6127.4 6198.7 6217.1 6277.2 6281.7 6185.1 6236.8 6258.0 6280.9 6406.5 5198.8 6238.5 6255.3 6288.3 6306.4 15:13:10 INFO - PROCESS | 3798 | 15:13:10 INFO - PROCESS | 3798 | [#1] ext.html Cycles:180 Average:51533.81 Median:204493.13 stddev:99104.23 (48.5%) stddev-sans-first:99308.84 15:13:10 INFO - PROCESS | 3798 | Values: 731.9 734.5 757.1 993.5 997.2 39355.6 40413.0 41520.4 41587.0 41615.0 30895.0 36723.0 37200.3 38500.6 38507.2 7982.5 8561.6 9259.8 9411.2 9419.2 8766.3 9482.0 9485.8 9499.9 9516.4 8044.3 9441.1 9504.0 9520.1 9521.2 9446.9 9463.0 9476.0 9482.8 9513.5 9280.6 9330.9 9339.9 9348.2 9351.5 30088.8 35923.5 35935.8 36130.8 36256.5 3796.5 3932.7 3942.9 3951.3 3996.0 26391.6 26482.7 27058.7 27260.6 27636.3 3219.7 3260.6 3265.0 3286.0 3312.6 255951.0 349905.0 353315.2 355616.0 358163.4 44556.9 44871.7 45080.7 45194.0 45203.5 47091.5 47159.0 47163.3 47213.0 47419.6 14279.5 14344.0 14419.6 14455.2 14470.4 12256.8 12339.8 12591.5 12611.6 12614.8 9124.5 9902.0 10492.6 10544.4 10575.4 4759.7 4800.7 4804.0 4814.1 4819.5 1140.8 1170.8 1178.8 1184.3 1225.0 23062.0 26857.5 27631.2 27639.3 27869.7 1082.8 1085.9 1143.7 1226.5 1284.0 13883.7 14230.6 14383.5 14468.9 14558.6 407224.0 407986.0 408346.0 408566.0 412004.0 56250.6 56320.4 56327.0 56349.2 56476.7 1496.8 1537.0 1548.7 1551.6 1561.2 25527.9 26667.7 26994.7 27119.2 27172.0 46492.0 46705.8 46711.6 46785.3 46807.8 371786.0 375642.0 377269.0 377273.0 377755.0 28046.9 28559.0 31736.4 32149.8 32966.0 44194.0 45543.8 45670.5 46334.8 46946.5 30156.7 31539.4 31577.0 31829.7 31978.7 31636.1 31958.8 32199.7 32230.0 32420.7 37209.4 37799.1 38055.9 38149.7 38252.0 30953.8 31954.9 32116.0 32312.8 32458.7 22174.7 22664.4 24481.8 25477.0 25756.7 15:13:10 INFO - PROCESS | 3798 | 15:13:10 INFO - PROCESS | 3798 | [#2] jquery.html Cycles:180 Average:42142.78 Median:22791.33 stddev:116434.37 (510.9%) stddev-sans-first:116718.85 15:13:10 INFO - PROCESS | 3798 | Values: 414.5 429.2 429.6 437.8 442.9 21107.4 22112.0 22196.6 23275.8 23508.4 22503.3 22785.8 23202.8 23487.4 23624.6 6929.7 7205.4 7220.5 7732.1 8070.4 7652.3 8140.4 8176.5 8197.5 8214.6 8086.2 8086.4 8121.6 8144.6 8151.3 7768.0 7891.0 7916.4 7953.7 7976.3 7291.9 7294.0 7534.5 7766.9 7907.8 26413.6 27017.6 27113.1 27141.2 27543.9 2904.3 3005.6 3074.6 3088.8 3093.0 15985.7 16071.9 16162.8 16188.6 16973.4 2093.7 2149.4 2152.6 2154.4 2163.2 135108.0 138700.0 169806.0 174653.1 174972.1 20380.7 21422.4 21490.8 21708.2 21712.0 33014.3 33301.0 33357.0 33357.5 33455.0 9101.4 10711.9 10982.8 11149.2 11192.0 9224.8 9251.5 9270.0 9274.2 9393.9 9839.4 9891.5 9919.3 9981.3 9982.5 4306.4 4394.2 4412.1 4421.8 4429.2 889.3 899.1 951.5 1050.0 1118.8 22256.4 22506.2 22601.5 22658.4 22796.9 911.0 1095.9 1125.7 1135.8 1135.9 9672.0 11033.7 11711.2 11729.6 11735.7 658714.0 689607.0 690947.5 694216.0 728378.0 160426.2 160516.0 162519.0 163604.4 170146.0 1092.3 1218.7 1315.5 1316.8 1334.4 19835.5 20034.2 20248.1 20390.8 20539.3 44015.0 57391.0 62508.0 63181.7 63761.7 71328.6 88640.1 90315.5 91586.6 91956.5 11108.4 11483.5 11521.7 11597.5 11678.5 12398.2 12637.3 12819.8 12939.9 13053.8 11099.0 11115.0 11189.1 11268.3 11292.8 10257.1 10349.7 10603.8 10690.6 10710.3 6447.6 8634.0 11176.4 11373.7 11444.5 11324.9 11477.2 11554.1 11682.8 11686.5 10080.7 10172.1 11005.9 11014.4 11265.0 15:13:10 INFO - PROCESS | 3798 | 15:13:10 INFO - PROCESS | 3798 | [#3] mootools.html Cycles:180 Average:6893.37 Median:2473.92 stddev:4257.22 (172.1%) stddev-sans-first:4249.28 15:13:10 INFO - PROCESS | 3798 | Values: 1418.8 1546.6 1605.8 1640.4 1640.4 10953.5 11663.7 11695.0 11748.2 12148.6 9675.0 11462.0 11622.8 11742.7 11765.9 2447.0 2495.0 2495.2 2495.6 2499.9 2416.7 2441.1 2473.4 2474.5 2492.3 1988.0 2366.5 2382.5 2474.4 2482.0 1961.7 2360.2 2400.1 2406.0 2444.2 2423.0 2457.6 2457.9 2461.0 2463.3 11260.8 11561.3 11600.2 11656.2 11727.2 5819.6 5931.9 5967.3 5971.3 5987.5 3633.0 3643.7 3677.6 3736.7 3775.9 1264.6 1267.6 1277.9 1304.3 1318.1 12391.8 12642.7 13210.5 13985.6 16235.0 4724.4 4726.6 4803.0 4838.0 4845.5 12254.7 12263.7 12276.4 12277.4 12347.0 5941.9 5991.4 6017.9 6025.8 6031.5 5363.5 5380.5 5436.5 5462.0 5524.2 3651.1 3758.6 4072.7 4094.0 4119.5 1050.7 1050.9 1053.6 1060.0 1063.8 971.5 990.8 998.9 1012.8 1020.8 6898.5 6966.3 6990.0 7009.9 7140.3 1070.7 1084.2 1096.6 1109.6 1115.3 4262.6 4298.2 4308.1 4666.1 4748.7 14013.8 14397.4 14407.9 14445.0 14460.9 14100.6 14168.1 14228.6 14310.6 14389.6 9953.3 10154.8 10178.7 10201.9 10229.6 6247.9 6930.3 7063.0 7210.4 7300.0 9567.3 12279.7 12825.0 12829.6 12832.5 11252.3 11460.3 12940.9 13141.0 13189.9 9462.3 9477.4 9497.1 9596.1 9598.0 10429.1 10549.5 10638.7 10652.5 10698.1 7559.6 9069.1 9077.2 9102.7 9122.1 8842.5 8909.7 8954.5 9148.0 9169.6 8076.6 8082.2 8112.8 8114.5 8149.3 5962.1 5989.9 6013.7 6195.1 6199.3 6010.4 6173.2 6217.8 6236.8 6304.3 15:13:10 INFO - PROCESS | 3798 | 15:13:10 INFO - PROCESS | 3798 | [#4] prototype.html Cycles:180 Average:4664.89 Median:5007.15 stddev:1316.12 (26.3%) stddev-sans-first:1279.58 15:13:10 INFO - PROCESS | 3798 | Values: 362.5 383.9 397.9 403.2 407.7 4541.6 5156.9 5262.8 5415.7 5571.8 4503.8 5246.8 5255.9 5268.7 5320.3 3576.9 4379.3 4425.9 4461.2 4461.4 3599.6 4389.3 4414.4 4439.4 4474.4 4093.6 4335.5 4344.3 4351.4 4396.1 4208.2 4346.8 4352.9 4380.7 4413.4 3625.8 4016.3 4081.2 4098.0 4138.8 4188.8 4274.3 4315.7 4962.4 5015.9 4569.2 4766.6 5050.0 5072.5 5141.9 4940.7 5085.0 5143.8 5632.2 5680.6 3463.8 3779.6 4526.5 4557.0 4588.3 5289.4 5389.6 5588.9 5593.6 5889.9 3845.4 3985.0 4119.9 4343.4 4425.4 4427.1 4579.9 4678.6 4690.1 4720.2 4194.0 4517.3 4765.8 4921.9 4924.7 4868.3 4887.8 4942.5 5246.4 5751.4 1344.0 1358.4 1525.8 1612.0 1627.8 1104.1 1141.9 1212.9 1218.7 1225.4 4719.8 4913.6 5100.9 5392.6 5448.9 5506.0 5833.0 5835.0 5893.6 5894.2 4752.9 4962.1 5134.2 5446.5 5497.3 2676.5 2769.9 2933.6 3030.8 3087.6 5170.5 5320.1 5343.5 5414.8 6077.1 5267.6 5654.5 5960.4 5997.9 6065.4 5222.0 5716.8 6112.0 6129.7 6151.5 4791.9 5588.8 5611.3 5861.7 5930.4 5430.3 5729.5 5778.4 5797.7 5800.0 5038.5 5146.5 5935.5 6076.5 6107.1 4159.7 4367.5 4556.4 4581.0 4596.8 5175.4 5282.3 5578.4 5764.3 5785.1 4851.4 5113.8 5720.7 5723.9 5757.9 4998.4 5653.7 5666.6 5683.4 5761.5 5217.8 5233.5 5581.7 5589.7 5666.5 4961.7 5637.3 5820.3 5820.7 5891.6 4429.6 5122.6 5369.8 5731.6 5754.0 15:13:10 INFO - PROCESS | 3798 | 15:13:10 INFO - PROCESS | 3798 | [#5] yui.html Cycles:180 Average:21015.60 Median:16579.55 stddev:30338.19 (183.0%) stddev-sans-first:30385.11 15:13:10 INFO - PROCESS | 3798 | Values: 742.1 742.6 769.3 800.7 912.8 14169.9 15880.4 16966.8 17281.7 17502.3 15607.6 16035.4 16156.7 16282.9 16292.4 999.8 1026.5 1027.4 1028.0 1028.6 801.9 1010.5 1022.4 1034.3 1035.3 1071.8 1076.3 1076.7 1078.6 1080.5 1063.2 1068.6 1071.1 1074.2 1075.6 782.6 792.2 793.5 796.0 796.3 16866.7 16955.4 16983.6 17786.1 17964.1 14356.5 14620.7 14703.1 14814.0 14977.9 11706.5 11757.4 11936.0 11997.7 12116.5 3748.1 3817.5 3859.6 3884.1 4024.8 111490.0 113011.4 114850.0 116466.0 116794.0 10930.3 11108.3 11155.4 11286.5 11312.3 22157.3 22205.0 22304.9 22325.9 22341.4 7450.2 7517.0 7596.6 7610.5 7636.3 4469.0 4541.4 4541.8 4570.2 4605.6 3532.7 3576.3 3598.4 3617.1 3636.3 659.1 665.8 670.4 680.0 682.6 498.3 667.9 682.3 687.2 687.8 9366.3 10169.9 10551.8 10629.2 10904.9 476.4 548.5 561.5 587.4 757.9 5192.7 5316.9 5359.5 5360.6 5404.9 104488.0 106885.0 107662.0 108104.0 110832.3 86887.1 89035.0 92313.0 93898.5 94765.1 79442.6 81545.8 81687.6 82556.6 82870.8 8061.9 8682.4 10180.5 10250.4 10295.8 45266.5 45735.0 45862.5 46825.3 47299.3 51882.5 57498.0 59847.8 64095.4 64794.0 12907.5 13099.7 13137.9 13197.2 13701.3 15223.8 15277.5 15493.4 15736.7 16172.5 14053.9 14280.2 14413.5 14463.8 14961.8 13947.2 14176.2 14348.8 14487.0 14888.9 13551.7 13683.6 14266.8 14351.0 14838.6 8864.0 10249.2 10569.5 10709.0 10762.9 10784.4 11373.2 11784.0 11848.9 11912.5 15:13:10 INFO - PROCESS | 3798 | -------- Summary: end -------- 15:13:10 INFO - PROCESS | 3798 | 15:13:11 INFO - TEST-INFO | 3798: exit 0 15:13:11 INFO - TEST-OK | dromaeo_css | took 1115705ms 15:13:11 INFO - TEST-START | kraken 15:13:11 INFO - operating with platform_type : mac_ 15:13:11 INFO - Initialising browser for kraken test... 15:13:11 INFO - TEST-INFO | started process 3803 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/tmpzx0_yS/profile http://localhost:53543/getInfo.html) 15:13:13 INFO - PROCESS | 3803 | 2017-05-07 15:13:13.895 plugin-container[3805:74343] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8437, name = 'com.apple.tsm.portname' 15:13:13 INFO - PROCESS | 3803 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:13:13 INFO - PROCESS | 3803 | 2017-05-07 15:13:13.895 plugin-container[3805:74343] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x860b, name = 'com.apple.CFPasteboardClient' 15:13:13 INFO - PROCESS | 3803 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:13:13 INFO - PROCESS | 3803 | 2017-05-07 15:13:13.895 plugin-container[3805:74343] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:13:13 INFO - PROCESS | 3803 | __metrics Screen width/height:1600/1200 15:13:13 INFO - PROCESS | 3803 | colorDepth:24 15:13:13 INFO - PROCESS | 3803 | Browser inner width/height: 1024/689 15:13:13 INFO - PROCESS | 3803 | __metrics 15:13:14 ERROR - PROCESS | 3803 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 15:13:14 INFO - TEST-INFO | 3803: exit 0 15:13:14 INFO - Browser initialized. 15:13:14 INFO - Running cycle 1/1 for kraken test... 15:13:14 INFO - TEST-INFO | started process 3806 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/tmpzx0_yS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:13:17 INFO - PROCESS | 3806 | 2017-05-07 15:13:17.169 plugin-container[3807:74465] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4547, name = 'com.apple.tsm.portname' 15:13:17 INFO - PROCESS | 3806 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:13:17 INFO - PROCESS | 3806 | 2017-05-07 15:13:17.170 plugin-container[3807:74465] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8327, name = 'com.apple.CFPasteboardClient' 15:13:17 INFO - PROCESS | 3806 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:13:17 INFO - PROCESS | 3806 | 2017-05-07 15:13:17.170 plugin-container[3807:74465] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:13:26 INFO - PROCESS | 3806 | RSS: Main: 174092288 15:13:26 INFO - PROCESS | 3806 | 15:13:30 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:53543/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53543/tests/kraken/driver.html?testName=audio-beat-detection) 15:13:31 INFO - PROCESS | 3806 | RSS: Main: 187858944 15:13:31 INFO - PROCESS | 3806 | 15:13:33 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:53543/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53543/tests/kraken/driver.html?testName=audio-dft) 15:13:34 INFO - PROCESS | 3806 | RSS: Main: 195907584 15:13:34 INFO - PROCESS | 3806 | 15:13:37 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:53543/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53543/tests/kraken/driver.html?testName=audio-fft) 15:13:38 INFO - PROCESS | 3806 | RSS: Main: 197496832 15:13:38 INFO - PROCESS | 3806 | 15:13:40 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:53543/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53543/tests/kraken/driver.html?testName=audio-oscillator) 15:13:40 INFO - PROCESS | 3806 | RSS: Main: 200179712 15:13:40 INFO - PROCESS | 3806 | 15:13:42 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:53543/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53543/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:13:43 INFO - PROCESS | 3806 | RSS: Main: 200802304 15:13:43 INFO - PROCESS | 3806 | 15:13:46 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:53543/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53543/tests/kraken/driver.html?testName=imaging-darkroom) 15:13:47 INFO - PROCESS | 3806 | RSS: Main: 205066240 15:13:47 INFO - PROCESS | 3806 | 15:13:50 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:53543/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53543/tests/kraken/driver.html?testName=imaging-desaturate) 15:13:51 INFO - PROCESS | 3806 | RSS: Main: 204042240 15:13:51 INFO - PROCESS | 3806 | 15:13:54 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:53543/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53543/tests/kraken/driver.html?testName=json-parse-financial) 15:13:54 INFO - PROCESS | 3806 | RSS: Main: 204783616 15:13:54 INFO - PROCESS | 3806 | 15:13:56 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:53543/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53543/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:13:57 INFO - PROCESS | 3806 | RSS: Main: 204451840 15:13:57 INFO - PROCESS | 3806 | 15:13:58 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:53543/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53543/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:13:59 INFO - PROCESS | 3806 | RSS: Main: 204439552 15:13:59 INFO - PROCESS | 3806 | 15:14:01 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:53543/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53543/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:14:02 INFO - PROCESS | 3806 | RSS: Main: 204500992 15:14:02 INFO - PROCESS | 3806 | 15:14:05 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:53543/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53543/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:14:05 INFO - PROCESS | 3806 | RSS: Main: 204869632 15:14:05 INFO - PROCESS | 3806 | 15:14:08 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:53543/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53543/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:14:09 INFO - PROCESS | 3806 | RSS: Main: 204615680 15:14:09 INFO - PROCESS | 3806 | 15:14:11 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:53543/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53543/tests/kraken/driver.html?testName=ai-astar) 15:14:11 INFO - PROCESS | 3806 | RSS: Main: 206647296 15:14:11 INFO - PROCESS | 3806 | 15:14:11 INFO - PROCESS | 3806 | __start_tp_report 15:14:11 INFO - PROCESS | 3806 | _x_x_mozilla_page_load 15:14:11 INFO - PROCESS | 3806 | _x_x_mozilla_page_load_details 15:14:11 INFO - PROCESS | 3806 | |i|pagename|runs| 15:14:11 INFO - PROCESS | 3806 | |0;ai-astar;114;179;165;121;120;121;119;131;178;157 15:14:11 INFO - PROCESS | 3806 | |1;audio-beat-detection;138;109;109;148;110;112;111;110;139;142 15:14:11 INFO - PROCESS | 3806 | |2;audio-dft;202;198;198;208;184;178;252;275;219;275 15:14:11 INFO - PROCESS | 3806 | |3;audio-fft;82;58;69;97;60;60;58;59;73;61 15:14:11 INFO - PROCESS | 3806 | |4;audio-oscillator;86;70;85;71;72;70;80;75;73;91 15:14:11 INFO - PROCESS | 3806 | |5;imaging-gaussian-blur;88;89;89;91;133;81;133;133;107;88 15:14:11 INFO - PROCESS | 3806 | |6;imaging-darkroom;95;98;95;96;126;154;94;131;92;153 15:14:11 INFO - PROCESS | 3806 | |7;imaging-desaturate;95;126;91;90;91;92;91;91;74;143 15:14:11 INFO - PROCESS | 3806 | |8;json-parse-financial;65;65;68;82;94;109;88;68;69;68 15:14:11 INFO - PROCESS | 3806 | |9;json-stringify-tinderbox;63;63;87;68;64;58;57;59;73;85 15:14:11 INFO - PROCESS | 3806 | |10;stanford-crypto-aes;85;86;88;95;82;89;83;81;88;98 15:14:11 INFO - PROCESS | 3806 | |11;stanford-crypto-ccm;139;137;146;130;118;136;162;149;159;150 15:14:11 INFO - PROCESS | 3806 | |12;stanford-crypto-pbkdf2;166;168;160;167;150;215;219;213;168;162 15:14:11 INFO - PROCESS | 3806 | |13;stanford-crypto-sha256-iterative;64;72;85;84;87;86;79;60;74;86 15:14:11 INFO - PROCESS | 3806 | __end_tp_report 15:14:11 INFO - PROCESS | 3806 | __start_cc_report 15:14:11 INFO - PROCESS | 3806 | _x_x_mozilla_cycle_collect,982 15:14:11 INFO - PROCESS | 3806 | __end_cc_report 15:14:11 INFO - PROCESS | 3806 | __startTimestamp1494195251671__endTimestamp 15:14:11 INFO - PROCESS | 3806 | 15:14:11 INFO - PROCESS | 3806 | ------- Summary: start ------- 15:14:11 INFO - PROCESS | 3806 | Number of tests: 14 15:14:11 INFO - PROCESS | 3806 | 15:14:11 INFO - PROCESS | 3806 | [#0] ai-astar Cycles:10 Average:140.50 Median:144.00 stddev:26.24 (18.2%) stddev-sans-first:26.02 15:14:11 INFO - PROCESS | 3806 | Values: 114.0 179.0 165.0 121.0 120.0 121.0 119.0 131.0 178.0 157.0 15:14:11 INFO - PROCESS | 3806 | 15:14:11 INFO - PROCESS | 3806 | [#1] audio-beat-detection Cycles:10 Average:122.80 Median:125.00 stddev:16.54 (13.2%) stddev-sans-first:16.60 15:14:11 INFO - PROCESS | 3806 | Values: 138.0 109.0 109.0 148.0 110.0 112.0 111.0 110.0 139.0 142.0 15:14:11 INFO - PROCESS | 3806 | 15:14:11 INFO - PROCESS | 3806 | [#2] audio-dft Cycles:10 Average:218.90 Median:213.50 stddev:35.84 (16.8%) stddev-sans-first:37.49 15:14:11 INFO - PROCESS | 3806 | Values: 202.0 198.0 198.0 208.0 184.0 178.0 252.0 275.0 219.0 275.0 15:14:11 INFO - PROCESS | 3806 | 15:14:11 INFO - PROCESS | 3806 | [#3] audio-fft Cycles:10 Average:67.70 Median:65.00 stddev:13.00 (20.0%) stddev-sans-first:12.71 15:14:11 INFO - PROCESS | 3806 | Values: 82.0 58.0 69.0 97.0 60.0 60.0 58.0 59.0 73.0 61.0 15:14:11 INFO - PROCESS | 3806 | 15:14:11 INFO - PROCESS | 3806 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:77.50 stddev:7.66 (9.9%) stddev-sans-first:7.45 15:14:11 INFO - PROCESS | 3806 | Values: 86.0 70.0 85.0 71.0 72.0 70.0 80.0 75.0 73.0 91.0 15:14:11 INFO - PROCESS | 3806 | 15:14:11 INFO - PROCESS | 3806 | [#5] imaging-gaussian-blur Cycles:10 Average:103.20 Median:88.00 stddev:21.57 (24.5%) stddev-sans-first:22.16 15:14:11 INFO - PROCESS | 3806 | Values: 88.0 89.0 89.0 91.0 133.0 81.0 133.0 133.0 107.0 88.0 15:14:11 INFO - PROCESS | 3806 | 15:14:11 INFO - PROCESS | 3806 | [#6] imaging-darkroom Cycles:10 Average:113.40 Median:94.50 stddev:25.25 (26.7%) stddev-sans-first:25.88 15:14:11 INFO - PROCESS | 3806 | Values: 95.0 98.0 95.0 96.0 126.0 154.0 94.0 131.0 92.0 153.0 15:14:11 INFO - PROCESS | 3806 | 15:14:11 INFO - PROCESS | 3806 | [#7] imaging-desaturate Cycles:10 Average:98.40 Median:91.00 stddev:20.24 (22.2%) stddev-sans-first:21.43 15:14:11 INFO - PROCESS | 3806 | Values: 95.0 126.0 91.0 90.0 91.0 92.0 91.0 91.0 74.0 143.0 15:14:11 INFO - PROCESS | 3806 | 15:14:11 INFO - PROCESS | 3806 | [#8] json-parse-financial Cycles:10 Average:77.60 Median:68.50 stddev:15.09 (22.0%) stddev-sans-first:15.31 15:14:11 INFO - PROCESS | 3806 | Values: 65.0 65.0 68.0 82.0 94.0 109.0 88.0 68.0 69.0 68.0 15:14:11 INFO - PROCESS | 3806 | 15:14:11 INFO - PROCESS | 3806 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:66.00 stddev:10.76 (16.3%) stddev-sans-first:11.28 15:14:11 INFO - PROCESS | 3806 | Values: 63.0 63.0 87.0 68.0 64.0 58.0 57.0 59.0 73.0 85.0 15:14:11 INFO - PROCESS | 3806 | 15:14:11 INFO - PROCESS | 3806 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:88.00 stddev:5.48 (6.2%) stddev-sans-first:5.74 15:14:11 INFO - PROCESS | 3806 | Values: 85.0 86.0 88.0 95.0 82.0 89.0 83.0 81.0 88.0 98.0 15:14:11 INFO - PROCESS | 3806 | 15:14:11 INFO - PROCESS | 3806 | [#11] stanford-crypto-ccm Cycles:10 Average:142.60 Median:147.50 stddev:13.35 (9.1%) stddev-sans-first:14.10 15:14:11 INFO - PROCESS | 3806 | Values: 139.0 137.0 146.0 130.0 118.0 136.0 162.0 149.0 159.0 150.0 15:14:11 INFO - PROCESS | 3806 | 15:14:11 INFO - PROCESS | 3806 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.80 Median:168.00 stddev:26.03 (15.5%) stddev-sans-first:27.19 15:14:11 INFO - PROCESS | 3806 | Values: 166.0 168.0 160.0 167.0 150.0 215.0 219.0 213.0 168.0 162.0 15:14:11 INFO - PROCESS | 3806 | 15:14:11 INFO - PROCESS | 3806 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.70 Median:84.50 stddev:9.81 (11.6%) stddev-sans-first:9.07 15:14:11 INFO - PROCESS | 3806 | Values: 64.0 72.0 85.0 84.0 87.0 86.0 79.0 60.0 74.0 86.0 15:14:11 INFO - PROCESS | 3806 | -------- Summary: end -------- 15:14:11 INFO - PROCESS | 3806 | 15:14:12 INFO - TEST-INFO | 3806: exit 0 15:14:12 INFO - TEST-OK | kraken | took 61293ms 15:14:12 INFO - SUITE-END | took 1176s 15:14:12 INFO - Completed test suite (00:19:37) 15:14:12 INFO - javascript benchmark 15:14:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7844.949042002814, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3500.614932357442, 3523.453864650979, 3550.92898142037, 3560.0921764949944, 3560.2523470071283, 6035.818925432233, 6062.242219722535, 6067.726952287141, 6129.417705317987, 6144.477719393857, 6042.879142417149, 6123.601965872226, 6131.3562075982045, 6157.091301696466, 6181.258249010125, 4790.712557246559, 5275.654708049442, 5468.7539060742165, 5506.80726174584, 5534.916976245359, 5559.694216818073, 5590.692511911843, 5593.496585307322, 5595.440455954393, 5624.072028115356, 4030.45588845505, 4542.273236282195, 5390.865228369303, 5543.196236545698, 5606.775728970836, 5486.451354864522, 5513.724313784335, 5575.721213939287, 5607.411221821691, 5625.774969001235, 5385.353757549119, 5500.944990550123, 5516.7517461714315, 5533.6403133796175, 5565.777368905239, 5928.466438020556, 6141.723622437001, 6151.569390142692, 6160.5687601867885, 6179.258488981306, 6325.652089135096, 6334.968325158345, 6347.238331400262, 6357.745690172387, 6374.266959299647, 5534.584906132056, 6563.851326017928, 6614.206295244601, 6646.069550262967, 6660.500462465335, 6227.813165605039, 6231.127642130105, 6244.438000579969, 6247.375262473762, 6252.874942501125, 6429.517786166056, 6440.323766004596, 6625.536212465081, 6665.766698165541, 6669.7665581704405, 6415.422611964946, 6438.25960014595, 6464.321246269074, 6508.088867558546, 6510.414062734377, 5534.225208470737, 6569.441597464269, 6645.269020407752, 6683.6658167091455, 6709.228438729609, 6225.128482012522, 6253.624782513064, 6346.809595712136, 6563.638999855054, 6569.408753212234, 6508.056331831953, 6539.280679125292, 6555.311692272338, 6556.0, 6560.475161987029, 5228.6339956203465, 5230.241614965808, 5257.737113144328, 5262.578993680497, 5285.233641122016, 4553.749543775058, 4579.5878370946775, 4666.357438191733, 4695.812167513262, 4739.810407583727, 6196.194494715748, 6212.751489940442, 6257.812265632038, 6261.405166509175, 6292.244930608356, 6597.703103360361, 6650.268470468244, 6651.201855777338, 6658.1011563438315, 6661.566998145105, 6102.298235702862, 6118.4668989547035, 6122.611623597813, 6248.000319948877, 6284.842878927972, 5718.370979192286, 5736.598438109292, 5742.885142297214, 5756.079027355603, 5773.960687076283, 6814.863702725818, 6826.931730682828, 6841.247462779091, 6876.656167191721, 6891.931080689229, 6269.686515674107, 6668.833279167866, 6683.598984060972, 6687.732490700318, 6693.26374098839, 6617.867642647217, 6707.698153583198, 6715.5299129060495, 6736.393724564813, 6758.357955994173, 6515.706793194412, 6526.477881769542, 6534.313897040743, 6535.771248006297, 6543.836404089936, 6570.113034740249, 6586.868262634624, 6612.140421745143, 6623.205215374186, 6624.171978502687, 6206.441420272197, 6225.657588832658, 6251.312355640966, 6260.467860231931, 6266.028765541349, 6240.188775459162, 6376.202974628171, 6381.904271436025, 6419.871602567829, 6444.355564443518, 6127.417895299939, 6198.721057552511, 6217.067439884054, 6277.2153480814895, 6281.71732272058, 6185.072239163981, 6236.812895613139, 6258.0, 6280.905786413116, 6406.487481001415, 5198.766055527435, 6238.532110091671, 6255.280642726145, 6288.339724328879, 6306.432421082125], "value": 5997.805359045255, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.8792399254123, 734.5115498193702, 757.1406453675081, 993.5280741647714, 997.242096007034, 39355.606443935554, 40413.0, 41520.37719434211, 41586.960325991866, 41615.0, 30895.0, 36723.0, 37200.255994880084, 38500.61499385005, 38507.22985540295, 7982.481138725993, 8561.630139177732, 9259.81480370394, 9411.152996230338, 9419.152276295132, 8766.298696104297, 9482.004389539103, 9485.762855928588, 9499.857502137473, 9516.381435206724, 8044.276015158634, 9441.10309520598, 9504.0, 9520.143187113159, 9521.190698790577, 9446.905530944672, 9463.0, 9475.952620236923, 9482.810343793086, 9513.47675877823, 9280.628774848998, 9330.906690933072, 9339.859902101474, 9348.158665720119, 9351.50375939853, 30088.79644814205, 35923.4611480828, 35935.82032089849, 36130.819345903365, 36256.45615315746, 3796.487474191004, 3932.744371615836, 3942.8817135485983, 3951.3480275754464, 3995.98002009991, 26391.604125938127, 26482.73517264822, 27058.729412706016, 27260.59109113365, 27636.30909227265, 3219.7263232625255, 3260.608726952757, 3264.9836750816094, 3286.0, 3312.569365982431, 255951.0, 349905.0, 353315.2334238338, 355616.0, 358163.4183658156, 44556.88607784767, 44871.653850384544, 45080.74596270173, 45194.0, 45203.54796452059, 47091.529084708716, 47159.0, 47163.349282774936, 47213.0, 47419.577412677674, 14279.500217492337, 14344.0, 14419.639509012359, 14455.204963726886, 14470.421183152766, 12256.81614775779, 12339.814902776465, 12591.496340146292, 12611.558595449298, 12614.81077783834, 9124.498152601538, 9901.950490247647, 10492.580296788043, 10544.367337959748, 10575.36547807134, 4759.6668233223345, 4800.687955282965, 4804.0, 4814.133455977888, 4819.542033562908, 1140.7547377313917, 1170.7599942011866, 1178.7524619829933, 1184.283508477376, 1224.9877501225053, 23062.0, 26857.462850743268, 27631.171064868086, 27639.30901727473, 27869.72130278712, 1082.7617924056694, 1085.8968398002178, 1143.6969203161168, 1226.5093962415106, 1283.9535778340623, 13883.722325553634, 14230.573082807532, 14383.51414276527, 14468.855311446961, 14558.563243102724, 407224.0, 407986.0, 408346.0, 408565.9571702182, 412004.0, 56250.59373515695, 56320.43679563152, 56327.0, 56349.15476267859, 56476.717616412476, 1496.8203815541988, 1536.9538913832603, 1548.6592949551307, 1551.5655616427418, 1561.203786069113, 25527.872360638077, 26667.733322666525, 26994.730052699222, 27119.1864244073, 27172.0, 46492.0, 46705.76647116878, 46711.59865203913, 46785.29822052604, 46807.76596116998, 371786.0, 375642.0, 377269.0, 377273.0, 377755.0, 28046.85976570104, 28559.000434984675, 31736.36527269488, 32149.839250803598, 32966.0, 44194.0, 45543.77228113838, 45670.54329456663, 46334.768326158155, 46946.53053469422, 30156.69843301539, 31539.423028848007, 31577.0, 31829.681703182672, 31978.680213198502, 31636.080901922793, 31958.84020579882, 32199.67800321967, 32230.0, 32420.675793241764, 37209.4418583716, 37799.05502362463, 38055.858324250315, 38149.664761733206, 38252.0, 30953.8452307746, 31954.881579144618, 32116.03651890447, 32312.83843580767, 32458.701651933658, 22174.667379989634, 22664.433389165402, 24481.75518244795, 25477.006726569212, 25756.742432575433], "value": 18198.504722136036, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.5377903637443, 429.24024476676306, 429.58545004071067, 437.8226818138654, 442.8959194589271, 21107.366778996635, 22112.0, 22196.556068878614, 23275.767242327613, 23508.412289692766, 22503.324900252977, 22785.772142278573, 23202.76797232027, 23487.412814679643, 23624.645630315557, 6929.722811087563, 7205.423566114724, 7220.530665506752, 7732.072151341847, 8070.435069545134, 7652.31129198372, 8140.43016988811, 8176.46852954559, 8197.549134797584, 8214.589270536479, 8086.231807978233, 8086.433949623529, 8121.553314567696, 8144.552049637267, 8151.266386025257, 7767.9611601941915, 7891.013623297088, 7916.366690664762, 7953.681852725884, 7976.282134607855, 7291.869760187179, 7293.963530182368, 7534.54792712439, 7766.922330776676, 7907.762767116996, 26413.603795943076, 27017.594736078976, 27113.05104321359, 27141.1857644271, 27543.898244070213, 2904.2739315171207, 3005.5792189093545, 3074.569560261565, 3088.799228050192, 3093.02569690549, 15985.680286394207, 16071.874968752192, 16162.838371616368, 16188.595285117848, 16973.405930792364, 2093.72781538399, 2149.3659370485743, 2152.612529744645, 2154.353693891826, 2163.2104281937136, 135107.999999999, 138700.0, 169806.0, 174653.1267343668, 174972.1251393735, 20380.694289585666, 21422.357329280145, 21490.78509214919, 21708.240211592518, 21712.022958966885, 33014.3397132056, 33301.0, 33356.99929002134, 33357.499637505454, 33454.99635010953, 9101.362904596615, 10711.946440267904, 10982.780344393068, 11149.219554631098, 11192.04867586248, 9224.7693807654, 9251.49116798569, 9269.980302166756, 9274.165325120772, 9393.859092113624, 9839.409635421898, 9891.455969921579, 9919.256055795844, 9981.301308908307, 9982.450965196838, 4306.354046892991, 4394.1870753910625, 4412.139632771643, 4421.7789110544345, 4429.2027435062, 889.3330002498126, 899.1188635137602, 951.4538874329215, 1049.960539066319, 1118.8209886418297, 22256.443588910406, 22506.21228257003, 22601.547969040526, 22658.433539161324, 22796.886015569817, 910.9933523456485, 1095.901368876805, 1125.7241975715838, 1135.7785231879704, 1135.8750537440874, 9672.032796720272, 11033.668989930315, 11711.1802173847, 11729.589464368706, 11735.706607334885, 658714.0, 689607.0, 690947.5452622805, 694216.0, 728378.0, 160426.19786900992, 160516.0, 162519.0, 163604.36395635892, 170146.0, 1092.317301686446, 1218.707510197564, 1315.4803852478217, 1316.82881225442, 1334.4061892457762, 19835.504112397306, 20034.198632055137, 20248.08883600212, 20390.796092039483, 20539.281125161146, 44015.0, 57391.0, 62508.0, 63181.68409157925, 63761.68119159374, 71328.57342853218, 88640.11359886319, 90315.5484222601, 91586.62620060571, 91956.54021729849, 11108.389038602954, 11483.483243253906, 11521.695660868028, 11597.478113485082, 11678.532858685558, 12398.194117382342, 12637.304948227937, 12819.807702884278, 12939.935300323814, 13053.804192937303, 11099.001089901947, 11114.999650031536, 11189.083820662703, 11268.267562608404, 11292.774144517229, 10257.128144107834, 10349.741256468347, 10603.840942386025, 10690.57237710514, 10710.303830251009, 6447.580907241015, 8633.96392432912, 11176.385298808644, 11373.715657108307, 11444.484998174936, 11324.94337528307, 11477.196596238184, 11554.133439992202, 11682.824757628812, 11686.532538698357, 10080.747981300527, 10172.08451239392, 11005.889941100806, 11014.39420831862, 11265.042471389695], "value": 12012.85444758728, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1418.7659036259017, 1546.5746919597113, 1605.759136129581, 1640.3766568703884, 1640.401253542457, 10953.45232738363, 11663.650090497287, 11695.0, 11748.236364636292, 12148.635540933765, 9675.0, 11461.968422841943, 11622.767544649101, 11742.706432339195, 11765.882241187095, 2447.0211915233917, 2494.950100997979, 2495.2264797912703, 2495.625656151574, 2499.8875050622673, 2416.7220769611454, 2441.0967941861536, 2473.3940184654784, 2474.5298393305306, 2492.277239600514, 1987.9503012424732, 2366.4675448024227, 2382.4877651304964, 2474.443250268693, 2482.0, 1961.7155512450686, 2360.221127028077, 2400.0879665726998, 2405.9639105413435, 2444.2300675287406, 2422.9757702422926, 2457.6313552967017, 2457.913973010936, 2461.0155937624913, 2463.3102731235103, 11260.831087533694, 11561.30632162073, 11600.187986840925, 11656.242344247681, 11727.17909746318, 5819.621724587931, 5931.940680593225, 5967.283925928917, 5971.343152253248, 5987.461128498456, 3633.0, 3643.6902863256655, 3677.5770786359644, 3736.7197460190323, 3775.9433608495897, 1264.6089301768075, 1267.5690265309838, 1277.9108934958542, 1304.3413076396455, 1318.057588823986, 12391.814122788166, 12642.735726427376, 13210.471581136742, 13985.58043258704, 16235.0, 4724.394038730669, 4726.645501587394, 4803.0, 4837.975810120927, 4845.49122342149, 12254.693632659077, 12263.69340766488, 12276.38618069093, 12277.38613069343, 12347.0, 5941.851453713692, 5991.370906054802, 6017.939820601826, 6025.8192254232445, 6031.457168854824, 5363.517283444508, 5380.461953804588, 5436.510714035756, 5462.044142275086, 5524.226608274845, 3651.1054791575702, 3758.605346438639, 4072.735272207297, 4093.97953010239, 4119.505659320841, 1050.6900464363032, 1050.9264351495322, 1053.5733028123623, 1060.0406631998055, 1063.7606538528769, 971.5482300730054, 990.7721224118493, 998.8801343838786, 1012.8480727890728, 1020.8213562626511, 6898.517103802786, 6966.268541803139, 6990.047645837663, 7009.859802803915, 7140.285971402922, 1070.6531975850864, 1084.1760262200785, 1096.6161843354762, 1109.611635927419, 1115.2973626615342, 4262.552431994658, 4298.20483210607, 4308.138372325548, 4666.136764698542, 4748.738819364969, 14013.789793153112, 14397.42410303576, 14407.855921440861, 14445.0, 14460.927695361666, 14100.576982690536, 14168.149911005372, 14228.644283892778, 14310.642233944234, 14389.568312950629, 9953.303268771262, 10154.796904061877, 10178.745531361626, 10201.948990255001, 10229.641962531276, 6247.9062814056915, 6930.306969303029, 7063.0, 7210.351068403869, 7299.963500182465, 9567.330286879851, 12279.69300767488, 12825.0, 12829.61511154667, 12832.486700532249, 11252.324860508395, 11460.255083419552, 12940.870591293966, 13141.0, 13189.868101319247, 9462.337636365388, 9477.431354118775, 9497.14525692691, 9596.136347728738, 9597.952010239904, 10429.06138447513, 10549.52527136296, 10638.73403164927, 10652.520636571218, 10698.144148467949, 7559.622018899143, 9069.138431848964, 9077.228435582785, 9102.726918192464, 9122.133397327243, 8842.513661748666, 8909.688160914337, 8954.507502087448, 9147.954260228656, 9169.633214671338, 8076.555789431638, 8082.15137410587, 8112.756617301255, 8114.472559283628, 8149.266566009088, 5962.105684147413, 5989.940100598938, 6013.6692481913915, 6195.070739389128, 6199.3490683477585, 6010.42900924429, 6173.228346456693, 6217.813465596039, 6236.781712640036, 6304.306526282197], "value": 5284.540251436285, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.46355394016854, 383.93665045267534, 397.92163237626033, 403.18355330455825, 407.6758976613592, 4541.591256786888, 5156.92264616031, 5262.763175657095, 5415.729213539322, 5571.832845014651, 4503.819847206116, 5246.7901283948595, 5255.923910055535, 5268.710220937856, 5320.308359913206, 3576.856925722968, 4379.321205213181, 4425.933610995838, 4461.174682683698, 4461.442319710036, 3599.5860476045195, 4389.310115605499, 4414.410812107639, 4439.400680908068, 4474.440694913136, 4093.6461534617565, 4335.479742430913, 4344.261475549164, 4351.434313539251, 4396.076823866992, 4208.179405016023, 4346.78266086696, 4352.891177720567, 4380.7152535085115, 4413.403076492648, 3625.800580968046, 4016.2971479990883, 4081.2041651877894, 4097.975506123469, 4138.8344466221315, 4188.81150348235, 4274.29474136767, 4315.697901146921, 4962.429320628138, 5015.921576860956, 4569.177548041352, 4766.594839438617, 5050.04049230645, 5072.467390923974, 5141.948580514222, 4940.654154209206, 5084.983003399335, 5143.7685304161405, 5632.239647647556, 5680.630759000693, 3463.809490478023, 3779.6031416701126, 4526.502084770673, 4557.020240648277, 4588.334691469719, 5289.418164001957, 5389.556547886624, 5588.944110558924, 5593.608447408683, 5889.882202355929, 3845.384738441892, 3984.9800750996637, 4119.855805046809, 4343.370211319341, 4425.402570652985, 4427.07422271313, 4579.900823802263, 4678.649101317346, 4690.1088793129875, 4720.150372932905, 4193.958060419357, 4517.299818528133, 4765.760902165462, 4921.8523444296725, 4924.655274130777, 4868.318435419044, 4887.804487820447, 4942.456329803718, 5246.383182799113, 5751.424857514216, 1343.9798403023963, 1358.3955139962623, 1525.7787620794923, 1612.0247250413565, 1627.8128015278157, 1104.0615476844778, 1141.8801025892328, 1212.8908398244023, 1218.65268398506, 1225.3873063468266, 4719.811207551728, 4913.606911447076, 5100.928804950928, 5392.595555333287, 5448.863778405493, 5505.9724701376235, 5833.0, 5834.970825145847, 5893.642542982841, 5894.229712035337, 4752.910608104759, 4962.146765609788, 5134.178531434953, 5446.509814116748, 5497.257870187474, 2676.531606968773, 2769.9197313047925, 2933.574631678395, 3030.8028328809996, 3087.644920834133, 5170.45710200431, 5320.068987927098, 5343.545798607084, 5414.756335964891, 6077.058056001327, 5267.604929630293, 5654.46282603152, 5960.4072228579835, 5997.910031349533, 6065.363136870653, 5221.973890130525, 5716.828495145152, 6111.96944015277, 6129.724162412791, 6151.5386346024225, 4791.945771930309, 5588.764494202352, 5611.270534830446, 5861.677607731445, 5930.377310382521, 5430.348358197041, 5729.54163666914, 5778.393268706725, 5797.681127538026, 5800.0, 5038.470960549236, 5146.536811686966, 5935.486450954979, 6076.473027594294, 6107.114468402146, 4159.667226621924, 4367.5414081520985, 4556.430446194226, 4580.999445363293, 4596.770161491979, 5175.404828444777, 5282.260483532232, 5578.414266502121, 5764.308283006066, 5785.119836053384, 4851.417829860439, 5113.795448182031, 5720.685362305113, 5723.914141287967, 5757.942420575908, 4998.375203099613, 5653.660780353192, 5666.575006874418, 5683.403242659461, 5761.48146666802, 5217.791288348423, 5233.528982391603, 5581.74882130297, 5589.6802826826415, 5666.546676265972, 4961.652684312064, 5637.267155269953, 5820.272465941757, 5820.73806678692, 5891.558133140117, 4429.601335879786, 5122.641415100908, 5369.785208591613, 5731.627444216113, 5753.964286428483], "value": 4284.010554003779, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.0946445336688, 742.5878637356268, 769.2730369800538, 800.7477644541968, 912.7854954085791, 14169.858301416984, 15880.444184453547, 16966.830331696678, 17281.70387220957, 17502.29990800368, 15607.609809754762, 16035.438759643415, 16156.676866462692, 16282.94160879542, 16292.42976495823, 999.7650552120245, 1026.5072765072769, 1027.3784360461925, 1027.9794404111913, 1028.598846449885, 801.9037715474151, 1010.5301035018715, 1022.3508072374021, 1034.3173505486382, 1035.3011717090972, 1071.791000754853, 1076.2573824061374, 1076.6716151573767, 1078.6116997880756, 1080.5461706083424, 1063.1813503602261, 1068.551208492435, 1071.1109778883508, 1074.156786922266, 1075.5643964194476, 782.6438970268514, 792.1800936031237, 793.5278509286965, 795.9562224077673, 796.2674339607574, 16866.662666746597, 16955.406560770312, 16983.57541061471, 17786.110694465355, 17964.101794910333, 14356.497522586764, 14620.70758584833, 14703.117812931258, 14814.0, 14977.925110374379, 11706.531738730526, 11757.35334556599, 11936.0, 11997.700057498545, 12116.515339386415, 3748.0629842539365, 3817.503724515795, 3859.6333348331864, 3884.126071633888, 4024.818883150236, 111489.99999999919, 113011.43494282558, 114850.0, 116466.0, 116794.0, 10930.344179349264, 11108.333499990027, 11155.442227888736, 11286.54853805855, 11312.264702794291, 22157.335279941628, 22205.000774965167, 22304.88847555752, 22325.888370558045, 22341.441463963532, 7450.18048014718, 7516.962415187889, 7596.5946299934685, 7610.467267291237, 7636.274553917369, 4468.955310446854, 4541.386912766734, 4541.841035563805, 4570.245909424974, 4605.585497305258, 3532.6643968822923, 3576.2668652926086, 3598.442241452579, 3617.0957260684827, 3636.254567813592, 659.1398225315913, 665.7569986954727, 670.4401824476519, 679.9728010879609, 682.5802131689074, 498.27003439959907, 667.864630128783, 682.3279070115932, 687.226869771507, 687.7695971849387, 9366.29752768545, 10169.9491502542, 10551.788964220827, 10629.202809789296, 10904.890951090387, 476.4354240225344, 548.5364866687643, 561.4525837308673, 587.4477990688739, 757.8938948547208, 5192.740362981911, 5316.946830531722, 5359.490848369399, 5360.624756267024, 5404.91892621611, 104488.0, 106885.0, 107662.0, 108104.0, 110832.33751493735, 86887.1311286879, 89035.0, 92313.0, 93898.53050734839, 94765.052349477, 79442.60278698569, 81545.77681334785, 81687.59156204181, 82556.58721706473, 82870.75693864597, 8061.87907181381, 8682.392232543662, 10180.541875615467, 10250.384976901112, 10295.794084118126, 45266.54733452755, 45735.0, 45862.541374585824, 46825.2976205364, 47299.29051064168, 51882.481175187764, 57498.0, 59847.80304393975, 64095.359046410806, 64794.02808957964, 12907.483700651868, 13099.67250818699, 13137.934310328386, 13197.20816750998, 13701.314934253447, 15223.847761522686, 15277.508030178176, 15493.380264789283, 15736.685266294839, 16172.514824555283, 14053.929730351283, 14280.167650602207, 14413.495527656902, 14463.783043254149, 14961.775573366625, 13947.232902190071, 14176.220307883166, 14348.784768228275, 14487.0, 14888.851111489179, 13551.72896542044, 13683.589492315246, 14266.785998209827, 14350.995430320196, 14838.629034274229, 8864.0, 10249.231307651808, 10569.524371403151, 10709.0, 10762.946185269024, 10784.352938823695, 11373.21061353256, 11784.019341551544, 11848.940755296167, 11912.523499060288], "value": 7851.80679122807, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1574.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 179.0, 165.0, 121.0, 120.0, 121.0, 119.0, 131.0, 178.0, 157.0], "value": 140.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 109.0, 109.0, 148.0, 110.0, 112.0, 111.0, 110.0, 139.0, 142.0], "value": 122.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 198.0, 198.0, 208.0, 184.0, 178.0, 252.0, 275.0, 219.0, 275.0], "value": 218.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 69.0, 97.0, 60.0, 60.0, 58.0, 59.0, 73.0, 61.0], "value": 67.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 85.0, 71.0, 72.0, 70.0, 80.0, 75.0, 73.0, 91.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 89.0, 91.0, 133.0, 81.0, 133.0, 133.0, 107.0, 88.0], "value": 103.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 98.0, 95.0, 96.0, 126.0, 154.0, 94.0, 131.0, 92.0, 153.0], "value": 113.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 126.0, 91.0, 90.0, 91.0, 92.0, 91.0, 91.0, 74.0, 143.0], "value": 98.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 68.0, 82.0, 94.0, 109.0, 88.0, 68.0, 69.0, 68.0], "value": 77.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 87.0, 68.0, 64.0, 58.0, 57.0, 59.0, 73.0, 85.0], "value": 67.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 88.0, 95.0, 82.0, 89.0, 83.0, 81.0, 88.0, 98.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 146.0, 130.0, 118.0, 136.0, 162.0, 149.0, 159.0, 150.0], "value": 142.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 168.0, 160.0, 167.0, 150.0, 215.0, 219.0, 213.0, 168.0, 162.0], "value": 178.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 85.0, 84.0, 87.0, 86.0, 79.0, 60.0, 74.0, 86.0], "value": 77.7, "unit": "score"}]}]} 15:14:12 INFO - Return code: 0 15:14:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:14:12 ERROR - # TBPL SUCCESS # 15:14:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:14:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:14:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:14:12 INFO - 2017-05-07 15:14:12.991 screenresolution[3811:74858] starting screenresolution argv=screenresolution get 15:14:12 INFO - 2017-05-07 15:14:12.994 screenresolution[3811:74858] Display 0: 1600x1200x32@60 15:14:13 INFO - 2017-05-07 15:14:13.000 screenresolution[3812:74861] starting screenresolution argv=screenresolution list 15:14:13 INFO - Available Modes on Display 0 15:14:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:14:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:14:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:14:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:14:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:14:13 INFO - Intel Iris: 15:14:13 INFO - Chipset Model: Intel Iris 15:14:13 INFO - Type: GPU 15:14:13 INFO - Bus: Built-In 15:14:13 INFO - VRAM (Dynamic, Max): 1536 MB 15:14:13 INFO - Vendor: Intel (0x8086) 15:14:13 INFO - Device ID: 0x0a2e 15:14:13 INFO - Revision ID: 0x0009 15:14:13 INFO - Displays: 15:14:13 INFO - Display: 15:14:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:14:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:14:13 INFO - Display Serial Number: 1600x1200 60 15:14:13 INFO - Main Display: Yes 15:14:13 INFO - Mirror: Off 15:14:13 INFO - Online: Yes 15:14:13 INFO - Rotation: Supported 15:14:13 INFO - Return code: 0 15:14:13 INFO - Running post-action listener: _resource_record_post_action 15:14:13 INFO - [mozharness: 2017-05-07 22:14:13.239865Z] Finished run-tests step (success) 15:14:13 INFO - Running post-run listener: _resource_record_post_run 15:14:13 INFO - Total resource usage - Wall time: 1192s; CPU: 54.0%; Read bytes: 851968; Write bytes: 427771904; Read time: 8; Write time: 1691 15:14:13 INFO - TinderboxPrint: CPU usage
54.4% 15:14:13 INFO - TinderboxPrint: I/O read bytes / time
851,968 / 8 15:14:13 INFO - TinderboxPrint: I/O write bytes / time
427,771,904 / 1,691 15:14:13 INFO - TinderboxPrint: CPU idle
2,174.1 (45.6%) 15:14:13 INFO - TinderboxPrint: CPU system
960.4 (20.1%) 15:14:13 INFO - TinderboxPrint: CPU user
1,635.1 (34.3%) 15:14:13 INFO - TinderboxPrint: Swap in / out
122,294,272 / 0 15:14:13 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 0; Write bytes: 122904576; Read time: 0; Write time: 252 15:14:13 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 712704; Write bytes: 303482880; Read time: 6; Write time: 1433 15:14:13 INFO - Running post-run listener: _upload_blobber_files 15:14:13 INFO - Blob upload gear active. 15:14:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:14:13 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 15:14:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:14:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:14:14 INFO - (blobuploader) - INFO - Open directory for files ... 15:14:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:14:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:14:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:14:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:14:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:14:14 INFO - (blobuploader) - INFO - Done attempting. 15:14:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:14:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:14:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:14:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:14:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:14:15 INFO - (blobuploader) - INFO - Done attempting. 15:14:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:14:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:14:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:14:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:14:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:14:16 INFO - (blobuploader) - INFO - Done attempting. 15:14:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:14:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:14:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:14:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:14:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:14:18 INFO - (blobuploader) - INFO - Done attempting. 15:14:18 INFO - (blobuploader) - INFO - Iteration through files over. 15:14:18 INFO - Return code: 0 15:14:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:14:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:14:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f6d8dfa7fb6e626cdbe357cc4c60d76e17b673d433752715ed125fa49a91229ee76db86ff2feef53d5133f6956a2ed58f8383e40dd2f0da7def1fe932db435f2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6cdf1735c43c4a63ec9d26e11ea93fa43c40da123cd078f49d84f3fae1b3b2abc7eacc0447556089b942a66af91f8efd0c2a0d52a0951047dd047c5aeeca79b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c2931a84112df78733a516ea496fe81b1eb5197728382f660df2b1e38bba7d6573c7a645b93e36d4fd44b508c9096c40d8052e185ca7e923259d96c7f79c059", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b62b7731814d7233a1603e2a3ce5806156ba8efa9bfc61dbfca03daa02f79904dfc752be89b198a4c4aa8248643dd6e89d228bd539088a5b6ea821a757f30f5"} 15:14:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:14:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:14:18 INFO - Contents: 15:14:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f6d8dfa7fb6e626cdbe357cc4c60d76e17b673d433752715ed125fa49a91229ee76db86ff2feef53d5133f6956a2ed58f8383e40dd2f0da7def1fe932db435f2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6cdf1735c43c4a63ec9d26e11ea93fa43c40da123cd078f49d84f3fae1b3b2abc7eacc0447556089b942a66af91f8efd0c2a0d52a0951047dd047c5aeeca79b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c2931a84112df78733a516ea496fe81b1eb5197728382f660df2b1e38bba7d6573c7a645b93e36d4fd44b508c9096c40d8052e185ca7e923259d96c7f79c059", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b62b7731814d7233a1603e2a3ce5806156ba8efa9bfc61dbfca03daa02f79904dfc752be89b198a4c4aa8248643dd6e89d228bd539088a5b6ea821a757f30f5"} 15:14:18 INFO - Running post-run listener: copy_logs_to_upload_dir 15:14:18 INFO - Copying logs to upload dir... 15:14:18 INFO - mkdir: /builds/slave/test/build/upload/logs 15:14:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.563322 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-05-07 15:14:18.878917) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-07 15:14:18.882578) ========= 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.3S1I5GRCFM/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.h2A9H6CthY/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f6d8dfa7fb6e626cdbe357cc4c60d76e17b673d433752715ed125fa49a91229ee76db86ff2feef53d5133f6956a2ed58f8383e40dd2f0da7def1fe932db435f2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6cdf1735c43c4a63ec9d26e11ea93fa43c40da123cd078f49d84f3fae1b3b2abc7eacc0447556089b942a66af91f8efd0c2a0d52a0951047dd047c5aeeca79b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c2931a84112df78733a516ea496fe81b1eb5197728382f660df2b1e38bba7d6573c7a645b93e36d4fd44b508c9096c40d8052e185ca7e923259d96c7f79c059", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b62b7731814d7233a1603e2a3ce5806156ba8efa9bfc61dbfca03daa02f79904dfc752be89b198a4c4aa8248643dd6e89d228bd539088a5b6ea821a757f30f5"} build_url:https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011206 build_url: 'https://queue.taskcluster.net/v1/task/OBLFjG9GTg25SdxSgRrwow/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f6d8dfa7fb6e626cdbe357cc4c60d76e17b673d433752715ed125fa49a91229ee76db86ff2feef53d5133f6956a2ed58f8383e40dd2f0da7def1fe932db435f2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6cdf1735c43c4a63ec9d26e11ea93fa43c40da123cd078f49d84f3fae1b3b2abc7eacc0447556089b942a66af91f8efd0c2a0d52a0951047dd047c5aeeca79b7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c2931a84112df78733a516ea496fe81b1eb5197728382f660df2b1e38bba7d6573c7a645b93e36d4fd44b508c9096c40d8052e185ca7e923259d96c7f79c059", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b62b7731814d7233a1603e2a3ce5806156ba8efa9bfc61dbfca03daa02f79904dfc752be89b198a4c4aa8248643dd6e89d228bd539088a5b6ea821a757f30f5"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-07 15:14:18.923317) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 15:14:18.923781) ========= 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.3S1I5GRCFM/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.h2A9H6CthY/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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.005387 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 15:14:18.976806) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-07 15:14:18.977668) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-07 15:14:18.978559) ========= ========= Total master_lag: 0.22 =========