builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0020 starttime: 1490744017.11 results: success (0) buildid: 20170328150822 builduid: e05e22548e5547a9bb9f101bd494f317 revision: d0f0b8b69e9a826ed266314cf1cfbde8e53438c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-28 16:33:37.107549) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-28 16:33:37.108060) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-28 16:33:37.108347) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-28 16:33:37.134993) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 16:33:37.135390) ========= 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.DbSeDRTmUE/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.yKlV9jC6jI/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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-03-28 16:33:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 29.1M=0s 2017-03-28 16:33:37 (29.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.150109 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 16:33:37.310069) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 16:33:37.310426) ========= 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.DbSeDRTmUE/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.yKlV9jC6jI/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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.028699 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 16:33:37.361049) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-03-28 16:33:37.361469) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d0f0b8b69e9a826ed266314cf1cfbde8e53438c4 --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 d0f0b8b69e9a826ed266314cf1cfbde8e53438c4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DbSeDRTmUE/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.yKlV9jC6jI/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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-03-28 16:33:37,605 truncating revision to first 12 chars 2017-03-28 16:33:37,605 Setting DEBUG logging. 2017-03-28 16:33:37,605 attempt 1/10 2017-03-28 16:33:37,605 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d0f0b8b69e9a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-28 16:33:38,987 unpacking tar archive at: mozilla-beta-d0f0b8b69e9a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.641596 ========= master_lag: 2.36 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-03-28 16:33:41.362262) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-28 16:33:41.362604) ========= script_repo_revision: d0f0b8b69e9a826ed266314cf1cfbde8e53438c4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-28 16:33:41.363016) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-28 16:33:41.363288) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-28 16:33:41.394934) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-03-28 16:33:41.395318) ========= /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.DbSeDRTmUE/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.yKlV9jC6jI/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 16:33:41 INFO - MultiFileLogger online at 20170328 16:33:41 in /builds/slave/test 16:33:41 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 16:33:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:33:41 INFO - {'append_to_log': False, 16:33:41 INFO - 'base_work_dir': '/builds/slave/test', 16:33:41 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:33:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:33:41 INFO - 'branch': 'Mozilla-Beta', 16:33:41 INFO - 'buildbot_json_path': 'buildprops.json', 16:33:41 INFO - 'config_files': ('talos/mac_config.py',), 16:33:41 INFO - 'default_actions': ('clobber', 16:33:41 INFO - 'read-buildbot-config', 16:33:41 INFO - 'download-and-extract', 16:33:41 INFO - 'populate-webroot', 16:33:41 INFO - 'create-virtualenv', 16:33:41 INFO - 'install', 16:33:41 INFO - 'run-tests'), 16:33:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:33:41 INFO - 'download_minidump_stackwalk': True, 16:33:41 INFO - 'download_symbols': 'ondemand', 16:33:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:33:41 INFO - 'tooltool.py': '/tools/tooltool.py', 16:33:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:33:41 INFO - '/tools/misc-python/virtualenv.py')}, 16:33:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:33:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:33:41 INFO - 'installer_path': 'installer.exe', 16:33:41 INFO - 'log_level': 'info', 16:33:41 INFO - 'log_name': 'talos', 16:33:41 INFO - 'log_to_console': True, 16:33:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:33:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:33:41 INFO - 'opt_config_files': (), 16:33:41 INFO - 'pip_index': False, 16:33:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:33:41 INFO - 'cmd': ('bash', 16:33:41 INFO - '-c', 16:33:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:33:41 INFO - 'enabled': True, 16:33:41 INFO - 'halt_on_failure': False, 16:33:41 INFO - 'name': 'check_screen_resolution'},), 16:33:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:33:41 INFO - 'cmd': ('bash', 16:33:41 INFO - '-c', 16:33:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:33:41 INFO - 'enabled': True, 16:33:41 INFO - 'halt_on_failure': False, 16:33:41 INFO - 'name': 'check_screen_resolution'},), 16:33:41 INFO - 'run_cmd_checks_enabled': True, 16:33:41 INFO - 'sps_profile': False, 16:33:41 INFO - 'sps_profile_interval': 0, 16:33:41 INFO - 'suite': 'dromaeojs-e10s', 16:33:41 INFO - 'system_bits': '32', 16:33:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:33:41 INFO - 'title': 't-yosemite-r7-0020', 16:33:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:33:41 INFO - 'use_talos_json': True, 16:33:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:33:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:33:41 INFO - 'work_dir': 'build'} 16:33:41 INFO - [mozharness: 2017-03-28 23:33:41.753323Z] Running clobber step. 16:33:41 INFO - Running pre-action listener: _resource_record_pre_action 16:33:41 INFO - Running main action method: clobber 16:33:41 INFO - rmtree: /builds/slave/test/build 16:33:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:33:44 INFO - Running post-action listener: _resource_record_post_action 16:33:44 INFO - [mozharness: 2017-03-28 23:33:44.305489Z] Finished clobber step (success) 16:33:44 INFO - [mozharness: 2017-03-28 23:33:44.305622Z] Running read-buildbot-config step. 16:33:44 INFO - Running pre-action listener: _resource_record_pre_action 16:33:44 INFO - Running main action method: read_buildbot_config 16:33:44 INFO - Using buildbot properties: 16:33:44 INFO - { 16:33:44 INFO - "project": "", 16:33:44 INFO - "product": "firefox", 16:33:44 INFO - "script_repo_revision": "production", 16:33:44 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 16:33:44 INFO - "repository": "", 16:33:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 16:33:44 INFO - "buildid": "20170328150822", 16:33:44 INFO - "pgo_build": "False", 16:33:44 INFO - "basedir": "/builds/slave/test", 16:33:44 INFO - "buildnumber": 5, 16:33:44 INFO - "slavename": "t-yosemite-r7-0020", 16:33:44 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 16:33:44 INFO - "platform": "yosemite_r7", 16:33:44 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 16:33:44 INFO - "branch": "mozilla-beta", 16:33:44 INFO - "repo_path": "releases/mozilla-beta", 16:33:44 INFO - "revision": "d0f0b8b69e9a826ed266314cf1cfbde8e53438c4", 16:33:44 INFO - "stage_platform": "macosx64", 16:33:44 INFO - "builduid": "e05e22548e5547a9bb9f101bd494f317", 16:33:44 INFO - "slavebuilddir": "test" 16:33:44 INFO - } 16:33:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/EfFEyO-RThqYztfVPt0FEA/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 16:33:44 INFO - Running post-action listener: _resource_record_post_action 16:33:44 INFO - [mozharness: 2017-03-28 23:33:44.308997Z] Finished read-buildbot-config step (success) 16:33:44 INFO - [mozharness: 2017-03-28 23:33:44.309110Z] Running download-and-extract step. 16:33:44 INFO - Running pre-action listener: _resource_record_pre_action 16:33:44 INFO - Running main action method: download_and_extract 16:33:44 INFO - mkdir: /builds/slave/test/build/tests 16:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:33:44 INFO - trying https://queue.taskcluster.net/v1/task/EfFEyO-RThqYztfVPt0FEA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 16:33:44 INFO - Downloading https://queue.taskcluster.net/v1/task/EfFEyO-RThqYztfVPt0FEA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 16:33:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EfFEyO-RThqYztfVPt0FEA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 16:33:45 INFO - Downloaded 1165 bytes. 16:33:45 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 16:33:45 INFO - Using the following test package requirements: 16:33:45 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 16:33:45 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:33:45 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 16:33:45 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:33:45 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 16:33:45 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 16:33:45 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:33:45 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 16:33:45 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 16:33:45 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:33:45 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 16:33:45 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:33:45 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 16:33:45 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:33:45 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 16:33:45 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:33:45 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 16:33:45 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 16:33:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EfFEyO-RThqYztfVPt0FEA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 16:33:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EfFEyO-RThqYztfVPt0FEA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 16:33:45 INFO - Fetch https://queue.taskcluster.net/v1/task/EfFEyO-RThqYztfVPt0FEA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 16:33:46 INFO - Expected file size: 16108830 16:33:46 INFO - Obtained file size: 16108830 16:33:52 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 16:33:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EfFEyO-RThqYztfVPt0FEA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 16:33:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EfFEyO-RThqYztfVPt0FEA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 16:33:52 INFO - Fetch https://queue.taskcluster.net/v1/task/EfFEyO-RThqYztfVPt0FEA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 16:33:53 INFO - Expected file size: 16108830 16:33:53 INFO - Obtained file size: 16108830 16:34:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EfFEyO-RThqYztfVPt0FEA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 16:34:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EfFEyO-RThqYztfVPt0FEA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 16:34:00 INFO - Fetch https://queue.taskcluster.net/v1/task/EfFEyO-RThqYztfVPt0FEA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 16:34:01 INFO - Expected file size: 14403663 16:34:01 INFO - Obtained file size: 14403663 16:34:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:01 INFO - trying https://queue.taskcluster.net/v1/task/EfFEyO-RThqYztfVPt0FEA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 16:34:01 INFO - Downloading https://queue.taskcluster.net/v1/task/EfFEyO-RThqYztfVPt0FEA/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 16:34:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EfFEyO-RThqYztfVPt0FEA/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 16:34:03 INFO - Downloaded 58678325 bytes. 16:34:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EfFEyO-RThqYztfVPt0FEA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 16:34:03 INFO - mkdir: /builds/slave/test/properties 16:34:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:34:03 INFO - Writing to file /builds/slave/test/properties/build_url 16:34:03 INFO - Contents: 16:34:03 INFO - build_url:https://queue.taskcluster.net/v1/task/EfFEyO-RThqYztfVPt0FEA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 16:34:03 INFO - Running post-action listener: _resource_record_post_action 16:34:03 INFO - Running post-action listener: set_extra_try_arguments 16:34:03 INFO - [mozharness: 2017-03-28 23:34:03.774171Z] Finished download-and-extract step (success) 16:34:03 INFO - [mozharness: 2017-03-28 23:34:03.774297Z] Running populate-webroot step. 16:34:03 INFO - Running pre-action listener: _resource_record_pre_action 16:34:03 INFO - Running main action method: populate_webroot 16:34:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:34:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:34:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:34:03 INFO - '--tppagecycles', 16:34:03 INFO - '7'], 16:34:03 INFO - 'tests': ['tsvgm']}}, 16:34:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:34:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:34:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:34:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:34:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:34:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:34:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:34:03 INFO - 'talos_options': ['--disable-e10s'], 16:34:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:34:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:34:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:34:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:34:03 INFO - 'talos_options': ['--disable-e10s'], 16:34:03 INFO - 'tests': ['damp', 'tps']}, 16:34:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:34:03 INFO - 'tests': ['damp', 'tps']}, 16:34:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:34:03 INFO - 'tests': ['dromaeo_dom']}, 16:34:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:34:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:34:03 INFO - 'tests': ['basic_compositor_video']}, 16:34:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:34:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:34:03 INFO - 'tests': ['a11yr', 16:34:03 INFO - 'ts_paint', 16:34:03 INFO - 'tpaint', 16:34:03 INFO - 'sessionrestore', 16:34:03 INFO - 'sessionrestore_no_auto_restore', 16:34:03 INFO - 'tabpaint']}, 16:34:03 INFO - 'other-e10s': {'tests': ['a11yr', 16:34:03 INFO - 'ts_paint', 16:34:03 INFO - 'tpaint', 16:34:03 INFO - 'sessionrestore', 16:34:03 INFO - 'sessionrestore_no_auto_restore', 16:34:03 INFO - 'tabpaint']}, 16:34:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:34:03 INFO - 'ts_paint', 16:34:03 INFO - 'tpaint', 16:34:03 INFO - 'sessionrestore', 16:34:03 INFO - 'sessionrestore_no_auto_restore', 16:34:03 INFO - 'tabpaint']}, 16:34:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:34:03 INFO - 'ts_paint', 16:34:03 INFO - 'tpaint', 16:34:03 INFO - 'sessionrestore', 16:34:03 INFO - 'sessionrestore_no_auto_restore', 16:34:03 INFO - 'tabpaint']}, 16:34:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:34:03 INFO - 'tests': ['a11yr', 16:34:03 INFO - 'ts_paint', 16:34:03 INFO - 'tpaint', 16:34:03 INFO - 'sessionrestore', 16:34:03 INFO - 'sessionrestore_no_auto_restore', 16:34:03 INFO - 'tabpaint']}, 16:34:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:34:03 INFO - 'tests': ['a11yr', 16:34:03 INFO - 'ts_paint', 16:34:03 INFO - 'tpaint', 16:34:03 INFO - 'sessionrestore', 16:34:03 INFO - 'sessionrestore_no_auto_restore', 16:34:03 INFO - 'tabpaint']}, 16:34:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:34:03 INFO - 'tests': ['tsvgx', 16:34:03 INFO - 'tsvgr_opacity', 16:34:03 INFO - 'tart', 16:34:03 INFO - 'tscrollx', 16:34:03 INFO - 'cart', 16:34:03 INFO - 'tsvg_static']}, 16:34:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:34:03 INFO - 'tsvgr_opacity', 16:34:03 INFO - 'tart', 16:34:03 INFO - 'tscrollx', 16:34:03 INFO - 'cart', 16:34:03 INFO - 'tsvg_static']}, 16:34:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:34:03 INFO - 'talos_options': ['--disable-e10s'], 16:34:03 INFO - 'tests': ['tp5o']}, 16:34:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:34:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:34:03 INFO - 'talos_options': ['--disable-e10s', 16:34:03 INFO - '--xperf_path', 16:34:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:34:03 INFO - 'tests': ['tp5n']}, 16:34:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:34:03 INFO - 'talos_options': ['--xperf_path', 16:34:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:34:03 INFO - 'tests': ['tp5n']}}, 16:34:03 INFO - 'talos.zip': {'path': '', 16:34:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:34:03 INFO - Running post-action listener: _resource_record_post_action 16:34:03 INFO - [mozharness: 2017-03-28 23:34:03.792661Z] Finished populate-webroot step (success) 16:34:03 INFO - [mozharness: 2017-03-28 23:34:03.792798Z] Running create-virtualenv step. 16:34:03 INFO - Running pre-action listener: _resource_record_pre_action 16:34:03 INFO - Running main action method: create_virtualenv 16:34:03 INFO - Creating virtualenv /builds/slave/test/build/venv 16:34:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:34:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:34:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:34:03 INFO - Using real prefix '/tools/python27' 16:34:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:34:04 INFO - Installing distribute.............................................................................................................................................................................................done. 16:34:07 INFO - Installing pip.................done. 16:34:07 INFO - Return code: 0 16:34:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:34:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:34:07 INFO - Reading from file tmpfile_stdout 16:34:07 INFO - Output received: 16:34:07 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) 16:34:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:34: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')]} 16:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34: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')]} 16:34:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0994c7110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbced30>, '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 0x10caf5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbc3be8>, '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.DbSeDRTmUE/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.yKlV9jC6jI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:34: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', 'pip>=1.5'] in /builds/slave/test/build 16:34: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 pip>=1.5 16:34:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DbSeDRTmUE/Render', 16:34:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:07 INFO - 'HOME': '/Users/cltbld', 16:34:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:07 INFO - 'LOGNAME': 'cltbld', 16:34:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:07 INFO - 'MOZ_NO_REMOTE': '1', 16:34:07 INFO - 'NO_EM_RESTART': '1', 16:34:07 INFO - 'PAGER': '/bin/cat', 16:34:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:07 INFO - 'PWD': '/builds/slave/test', 16:34:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:07 INFO - 'SHELL': '/bin/bash', 16:34:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yKlV9jC6jI/Listeners', 16:34:07 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 16:34:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:07 INFO - 'USER': 'cltbld', 16:34:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:07 INFO - 'XPC_FLAGS': '0x0', 16:34:07 INFO - 'XPC_SERVICE_NAME': '0', 16:34:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:34:08 INFO - Cleaning up... 16:34:08 INFO - Return code: 0 16:34:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:34:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:08 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 0x10cdf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0994c7110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbced30>, '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 0x10caf5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbc3be8>, '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.DbSeDRTmUE/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.yKlV9jC6jI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:34:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:34:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:34:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DbSeDRTmUE/Render', 16:34:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:08 INFO - 'HOME': '/Users/cltbld', 16:34:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:08 INFO - 'LOGNAME': 'cltbld', 16:34:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:08 INFO - 'MOZ_NO_REMOTE': '1', 16:34:08 INFO - 'NO_EM_RESTART': '1', 16:34:08 INFO - 'PAGER': '/bin/cat', 16:34:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:08 INFO - 'PWD': '/builds/slave/test', 16:34:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:08 INFO - 'SHELL': '/bin/bash', 16:34:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yKlV9jC6jI/Listeners', 16:34:08 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 16:34:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:08 INFO - 'USER': 'cltbld', 16:34:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:08 INFO - 'XPC_FLAGS': '0x0', 16:34:08 INFO - 'XPC_SERVICE_NAME': '0', 16:34:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:08 INFO - Downloading/unpacking psutil>=3.1.1 16:34:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:34:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:34:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:34:11 INFO - Installing collected packages: psutil 16:34:11 INFO - Running setup.py install for psutil 16:34:11 INFO - building 'psutil._psutil_osx' extension 16:34:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 16:34:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 16:34:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 16:34:12 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 16:34:12 INFO - building 'psutil._psutil_posix' extension 16:34:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 16:34:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:34:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:34:12 INFO - ^ 16:34:12 INFO - 1 warning generated. 16:34:12 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 16:34:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:34:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:34:13 INFO - Successfully installed psutil 16:34:13 INFO - Cleaning up... 16:34:13 INFO - Return code: 0 16:34:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:13 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 0x10cdf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0994c7110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbced30>, '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 0x10caf5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbc3be8>, '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.DbSeDRTmUE/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.yKlV9jC6jI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:34:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:34:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:34:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DbSeDRTmUE/Render', 16:34:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:13 INFO - 'HOME': '/Users/cltbld', 16:34:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:13 INFO - 'LOGNAME': 'cltbld', 16:34:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:13 INFO - 'MOZ_NO_REMOTE': '1', 16:34:13 INFO - 'NO_EM_RESTART': '1', 16:34:13 INFO - 'PAGER': '/bin/cat', 16:34:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:13 INFO - 'PWD': '/builds/slave/test', 16:34:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:13 INFO - 'SHELL': '/bin/bash', 16:34:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yKlV9jC6jI/Listeners', 16:34:13 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 16:34:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:13 INFO - 'USER': 'cltbld', 16:34:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:13 INFO - 'XPC_FLAGS': '0x0', 16:34:13 INFO - 'XPC_SERVICE_NAME': '0', 16:34:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:34:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:34:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:34:15 INFO - Installing collected packages: mozsystemmonitor 16:34:15 INFO - Running setup.py install for mozsystemmonitor 16:34:16 INFO - Successfully installed mozsystemmonitor 16:34:16 INFO - Cleaning up... 16:34:16 INFO - Return code: 0 16:34:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:34:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:16 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 0x10cdf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0994c7110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbced30>, '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 0x10caf5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbc3be8>, '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.DbSeDRTmUE/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.yKlV9jC6jI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:34:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:34:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:34:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DbSeDRTmUE/Render', 16:34:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:16 INFO - 'HOME': '/Users/cltbld', 16:34:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:16 INFO - 'LOGNAME': 'cltbld', 16:34:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:16 INFO - 'MOZ_NO_REMOTE': '1', 16:34:16 INFO - 'NO_EM_RESTART': '1', 16:34:16 INFO - 'PAGER': '/bin/cat', 16:34:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:16 INFO - 'PWD': '/builds/slave/test', 16:34:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:16 INFO - 'SHELL': '/bin/bash', 16:34:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yKlV9jC6jI/Listeners', 16:34:16 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 16:34:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:16 INFO - 'USER': 'cltbld', 16:34:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:16 INFO - 'XPC_FLAGS': '0x0', 16:34:16 INFO - 'XPC_SERVICE_NAME': '0', 16:34:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:16 INFO - Downloading/unpacking jsonschema==2.5.1 16:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:34:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:19 INFO - Downloading functools32-3.2.3-2.tar.gz 16:34:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:34:19 INFO - warning: no files found matching '*.txt' 16:34:19 INFO - no previously-included directories found matching 'build' 16:34:19 INFO - no previously-included directories found matching 'dist' 16:34:19 INFO - no previously-included directories found matching '.git*' 16:34:19 INFO - Installing collected packages: jsonschema, functools32 16:34:19 INFO - Running setup.py install for functools32 16:34:19 INFO - warning: no files found matching '*.txt' 16:34:19 INFO - no previously-included directories found matching 'build' 16:34:19 INFO - no previously-included directories found matching 'dist' 16:34:19 INFO - no previously-included directories found matching '.git*' 16:34:19 INFO - Successfully installed jsonschema functools32 16:34:19 INFO - Cleaning up... 16:34:19 INFO - Return code: 0 16:34:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:34: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')]} 16:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34: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')]} 16:34:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34: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', '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 0x10cdf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0994c7110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbced30>, '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 0x10caf5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbc3be8>, '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.DbSeDRTmUE/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.yKlV9jC6jI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:34: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:34: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 functools32==3.2.3-2 16:34:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DbSeDRTmUE/Render', 16:34:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:19 INFO - 'HOME': '/Users/cltbld', 16:34:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:19 INFO - 'LOGNAME': 'cltbld', 16:34:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:19 INFO - 'MOZ_NO_REMOTE': '1', 16:34:19 INFO - 'NO_EM_RESTART': '1', 16:34:19 INFO - 'PAGER': '/bin/cat', 16:34:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:19 INFO - 'PWD': '/builds/slave/test', 16:34:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:19 INFO - 'SHELL': '/bin/bash', 16:34:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yKlV9jC6jI/Listeners', 16:34:19 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 16:34:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:19 INFO - 'USER': 'cltbld', 16:34:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:19 INFO - 'XPC_FLAGS': '0x0', 16:34:19 INFO - 'XPC_SERVICE_NAME': '0', 16:34:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:34:20 INFO - Cleaning up... 16:34:20 INFO - Return code: 0 16:34:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:34:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:20 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 0x10cdf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0994c7110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbced30>, '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 0x10caf5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbc3be8>, '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.DbSeDRTmUE/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.yKlV9jC6jI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:34:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:34:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:34:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DbSeDRTmUE/Render', 16:34:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:20 INFO - 'HOME': '/Users/cltbld', 16:34:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:20 INFO - 'LOGNAME': 'cltbld', 16:34:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:20 INFO - 'MOZ_NO_REMOTE': '1', 16:34:20 INFO - 'NO_EM_RESTART': '1', 16:34:20 INFO - 'PAGER': '/bin/cat', 16:34:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:20 INFO - 'PWD': '/builds/slave/test', 16:34:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:20 INFO - 'SHELL': '/bin/bash', 16:34:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yKlV9jC6jI/Listeners', 16:34:20 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 16:34:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:20 INFO - 'USER': 'cltbld', 16:34:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:20 INFO - 'XPC_FLAGS': '0x0', 16:34:20 INFO - 'XPC_SERVICE_NAME': '0', 16:34:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:20 INFO - Downloading/unpacking blobuploader==1.2.4 16:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:23 INFO - Downloading blobuploader-1.2.4.tar.gz 16:34:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:34:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:34:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:24 INFO - Downloading docopt-0.6.1.tar.gz 16:34:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:34:24 INFO - Installing collected packages: blobuploader, requests, docopt 16:34:24 INFO - Running setup.py install for blobuploader 16:34:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:34:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:34:24 INFO - Running setup.py install for requests 16:34:25 INFO - Running setup.py install for docopt 16:34:25 INFO - Successfully installed blobuploader requests docopt 16:34:25 INFO - Cleaning up... 16:34:25 INFO - Return code: 0 16:34:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:25 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 0x10cdf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0994c7110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbced30>, '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 0x10caf5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbc3be8>, '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.DbSeDRTmUE/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.yKlV9jC6jI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:34:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:34:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:34:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DbSeDRTmUE/Render', 16:34:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:25 INFO - 'HOME': '/Users/cltbld', 16:34:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:25 INFO - 'LOGNAME': 'cltbld', 16:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:25 INFO - 'MOZ_NO_REMOTE': '1', 16:34:25 INFO - 'NO_EM_RESTART': '1', 16:34:25 INFO - 'PAGER': '/bin/cat', 16:34:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:25 INFO - 'PWD': '/builds/slave/test', 16:34:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:25 INFO - 'SHELL': '/bin/bash', 16:34:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yKlV9jC6jI/Listeners', 16:34:25 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 16:34:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:25 INFO - 'USER': 'cltbld', 16:34:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:25 INFO - 'XPC_FLAGS': '0x0', 16:34:25 INFO - 'XPC_SERVICE_NAME': '0', 16:34:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:34:25 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-qhSAuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:34:25 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-2vgru8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:34:25 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-2_8JP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:34:25 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-_ECnG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:34:26 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-TmAHun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:34:26 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-2PiLVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:34:26 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-AMNJs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:34:26 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-XVdHZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:34:26 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-25WY7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:34:26 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-E5aOcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:34:26 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-_5CklO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:34:26 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-CREfCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:34:26 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-MY20Nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:34:26 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-aSF0oW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:34:27 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-QQus9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:34:27 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-CzR8tQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:34:27 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-V8ewSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:34:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:34:27 INFO - Running setup.py install for manifestparser 16:34:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:34:27 INFO - Running setup.py install for mozcrash 16:34:27 INFO - Running setup.py install for mozdebug 16:34:27 INFO - Running setup.py install for mozdevice 16:34:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:34:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:34:27 INFO - Running setup.py install for mozfile 16:34:28 INFO - Running setup.py install for mozhttpd 16:34:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:34:28 INFO - Running setup.py install for mozinfo 16:34:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:34:28 INFO - Running setup.py install for mozInstall 16:34:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:34:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:34:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:34:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:34:28 INFO - Running setup.py install for mozleak 16:34:28 INFO - Running setup.py install for mozlog 16:34:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:34:28 INFO - Running setup.py install for moznetwork 16:34:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:34:29 INFO - Running setup.py install for mozprocess 16:34:29 INFO - Running setup.py install for mozprofile 16:34:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:34:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:34:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:34:29 INFO - Running setup.py install for mozrunner 16:34:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:34:29 INFO - Running setup.py install for mozscreenshot 16:34:29 INFO - Running setup.py install for moztest 16:34:29 INFO - Running setup.py install for mozversion 16:34:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:34:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:34:29 INFO - Cleaning up... 16:34:29 INFO - Return code: 0 16:34:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:29 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 0x10cdf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0994c7110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbced30>, '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 0x10caf5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbc3be8>, '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.DbSeDRTmUE/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.yKlV9jC6jI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:34:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:34:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:34:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DbSeDRTmUE/Render', 16:34:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:29 INFO - 'HOME': '/Users/cltbld', 16:34:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:29 INFO - 'LOGNAME': 'cltbld', 16:34:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:29 INFO - 'MOZ_NO_REMOTE': '1', 16:34:29 INFO - 'NO_EM_RESTART': '1', 16:34:29 INFO - 'PAGER': '/bin/cat', 16:34:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:29 INFO - 'PWD': '/builds/slave/test', 16:34:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:29 INFO - 'SHELL': '/bin/bash', 16:34:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yKlV9jC6jI/Listeners', 16:34:29 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 16:34:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:29 INFO - 'USER': 'cltbld', 16:34:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:29 INFO - 'XPC_FLAGS': '0x0', 16:34:29 INFO - 'XPC_SERVICE_NAME': '0', 16:34:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:34:30 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-mRZsJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:34:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:34:30 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-7bAkfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:34:30 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)) 16:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:34:30 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-qwz4gX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:34:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:34:30 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-PnkPCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:34:30 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)) 16:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:34:30 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-pZ5A2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:34:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:34:30 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-VNWX3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:34:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:34:30 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-Abhsss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:34:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:34:30 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-yFmgVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:34:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:34:31 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-EqzYLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:34:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:34:31 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-JohpLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:34:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:34:31 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-US456w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:34:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:34:31 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-PRS_gF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:34:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:34:31 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-brNuej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:34:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:34:31 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-bQ4IcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:34:31 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)) 16:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:34:31 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-nXACxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:34:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:34:31 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-We4tSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:34:31 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)) 16:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:34:31 INFO - Running setup.py (path:/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/pip-_TYowK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:34:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:34:32 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)) 16:34:32 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)) 16:34:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:34:32 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)) 16:34:32 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)) 16:34:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:34:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:34 INFO - Downloading blessings-1.6.tar.gz 16:34:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:34:34 INFO - Installing collected packages: blessings 16:34:34 INFO - Running setup.py install for blessings 16:34:34 INFO - Successfully installed blessings 16:34:34 INFO - Cleaning up... 16:34:35 INFO - Return code: 0 16:34:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:34:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:34:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:34:35 INFO - Reading from file tmpfile_stdout 16:34:35 INFO - Current package versions: 16:34:35 INFO - blessings == 1.6 16:34:35 INFO - blobuploader == 1.2.4 16:34:35 INFO - docopt == 0.6.1 16:34:35 INFO - functools32 == 3.2.3-2 16:34:35 INFO - jsonschema == 2.5.1 16:34:35 INFO - manifestparser == 1.1 16:34:35 INFO - mozInstall == 1.12 16:34:35 INFO - mozcrash == 1.0 16:34:35 INFO - mozdebug == 0.1 16:34:35 INFO - mozdevice == 0.49 16:34:35 INFO - mozfile == 1.2 16:34:35 INFO - mozhttpd == 0.7 16:34:35 INFO - mozinfo == 0.9 16:34:35 INFO - mozleak == 0.1 16:34:35 INFO - mozlog == 3.4 16:34:35 INFO - moznetwork == 0.27 16:34:35 INFO - mozprocess == 0.24 16:34:35 INFO - mozprofile == 0.28 16:34:35 INFO - mozrunner == 6.13 16:34:35 INFO - mozscreenshot == 0.1 16:34:35 INFO - mozsystemmonitor == 0.3 16:34:35 INFO - moztest == 0.8 16:34:35 INFO - mozversion == 1.4 16:34:35 INFO - psutil == 3.1.1 16:34:35 INFO - requests == 1.2.3 16:34:35 INFO - wsgiref == 0.1.2 16:34:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:34: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')]} 16:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34: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')]} 16:34:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:35 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 0x10cdf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0994c7110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbced30>, '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 0x10caf5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbc3be8>, '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.DbSeDRTmUE/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.yKlV9jC6jI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:34:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:34:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:34:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DbSeDRTmUE/Render', 16:34:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:35 INFO - 'HOME': '/Users/cltbld', 16:34:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:35 INFO - 'LOGNAME': 'cltbld', 16:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:35 INFO - 'MOZ_NO_REMOTE': '1', 16:34:35 INFO - 'NO_EM_RESTART': '1', 16:34:35 INFO - 'PAGER': '/bin/cat', 16:34:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:35 INFO - 'PWD': '/builds/slave/test', 16:34:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:35 INFO - 'SHELL': '/bin/bash', 16:34:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yKlV9jC6jI/Listeners', 16:34:35 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 16:34:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:35 INFO - 'USER': 'cltbld', 16:34:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:35 INFO - 'XPC_FLAGS': '0x0', 16:34:35 INFO - 'XPC_SERVICE_NAME': '0', 16:34:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:34:36 INFO - Cleaning up... 16:34:36 INFO - Return code: 0 16:34:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:34:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:36 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 0x10cdf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0994c7110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbced30>, '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 0x10caf5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbc3be8>, '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.DbSeDRTmUE/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.yKlV9jC6jI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:34:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:34:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:34:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DbSeDRTmUE/Render', 16:34:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:36 INFO - 'HOME': '/Users/cltbld', 16:34:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:36 INFO - 'LOGNAME': 'cltbld', 16:34:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:36 INFO - 'MOZ_NO_REMOTE': '1', 16:34:36 INFO - 'NO_EM_RESTART': '1', 16:34:36 INFO - 'PAGER': '/bin/cat', 16:34:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:36 INFO - 'PWD': '/builds/slave/test', 16:34:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:36 INFO - 'SHELL': '/bin/bash', 16:34:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yKlV9jC6jI/Listeners', 16:34:36 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 16:34:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:36 INFO - 'USER': 'cltbld', 16:34:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:36 INFO - 'XPC_FLAGS': '0x0', 16:34:36 INFO - 'XPC_SERVICE_NAME': '0', 16:34:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:34:36 INFO - Cleaning up... 16:34:36 INFO - Return code: 0 16:34:36 INFO - Running post-action listener: _resource_record_post_action 16:34:36 INFO - Running post-action listener: _start_resource_monitoring 16:34:36 INFO - Starting resource monitoring. 16:34:36 INFO - [mozharness: 2017-03-28 23:34:36.876408Z] Finished create-virtualenv step (success) 16:34:36 INFO - [mozharness: 2017-03-28 23:34:36.877347Z] Running install step. 16:34:36 INFO - Running pre-action listener: _resource_record_pre_action 16:34:36 INFO - Running main action method: install 16:34:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:34:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:34:37 INFO - Reading from file tmpfile_stdout 16:34:37 INFO - Detecting whether we're running mozinstall >=1.0... 16:34:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:34:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:34:37 INFO - Reading from file tmpfile_stdout 16:34:37 INFO - Output received: 16:34:37 INFO - Usage: mozinstall [options] installer 16:34:37 INFO - Options: 16:34:37 INFO - -h, --help show this help message and exit 16:34:37 INFO - -d DEST, --destination=DEST 16:34:37 INFO - Directory to install application into. [default: 16:34:37 INFO - "/builds/slave/test"] 16:34:37 INFO - --app=APP Application being installed. [default: firefox] 16:34:37 INFO - mkdir: /builds/slave/test/build/application 16:34:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:34:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 16:34:51 INFO - Reading from file tmpfile_stdout 16:34:51 INFO - Output received: 16:34:51 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 16:34:51 INFO - Running post-action listener: _resource_record_post_action 16:34:51 INFO - [mozharness: 2017-03-28 23:34:51.683954Z] Finished install step (success) 16:34:51 INFO - [mozharness: 2017-03-28 23:34:51.684081Z] Running run-tests step. 16:34:51 INFO - Running pre-action listener: _resource_record_pre_action 16:34:51 INFO - Running main action method: run_tests 16:34:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:34:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:34:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:34:51 INFO - 2017-03-28 16:34:51.698 screenresolution[1622:7342] starting screenresolution argv=screenresolution get 16:34:51 INFO - 2017-03-28 16:34:51.700 screenresolution[1622:7342] Display 0: 1600x1200x32@60 16:34:51 INFO - 2017-03-28 16:34:51.705 screenresolution[1623:7344] starting screenresolution argv=screenresolution list 16:34:51 INFO - Available Modes on Display 0 16:34:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:34:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:34:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:34:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:34:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:34:51 INFO - Intel Iris: 16:34:51 INFO - Chipset Model: Intel Iris 16:34:51 INFO - Type: GPU 16:34:51 INFO - Bus: Built-In 16:34:51 INFO - VRAM (Dynamic, Max): 1536 MB 16:34:51 INFO - Vendor: Intel (0x8086) 16:34:51 INFO - Device ID: 0x0a2e 16:34:51 INFO - Revision ID: 0x0009 16:34:51 INFO - Displays: 16:34:51 INFO - Display: 16:34:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:34:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:34:51 INFO - Display Serial Number: 1600x1200 60 16:34:51 INFO - Main Display: Yes 16:34:51 INFO - Mirror: Off 16:34:51 INFO - Online: Yes 16:34:51 INFO - Rotation: Supported 16:34:51 INFO - Return code: 0 16:34:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:34:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:34:51 INFO - Python 2.7.3 16:34:51 INFO - Return code: 0 16:34:51 INFO - grabbing minidump binary from tooltool 16:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:51 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 0x10cbced30>, '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 0x10caf5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbc3be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:34:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:34:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 16:34:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:34:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:34:52 INFO - Return code: 0 16:34:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:34:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:34:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:34:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:34:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:34:52 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/EfFEyO-RThqYztfVPt0FEA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0020', '--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 16:34:52 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/EfFEyO-RThqYztfVPt0FEA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0020 --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 16:34:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DbSeDRTmUE/Render', 16:34:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:34:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:34:52 INFO - 'HOME': '/Users/cltbld', 16:34:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:34:52 INFO - 'LOGNAME': 'cltbld', 16:34:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:34:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:34:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:52 INFO - 'MOZ_NO_REMOTE': '1', 16:34:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:34:52 INFO - 'NO_EM_RESTART': '1', 16:34:52 INFO - 'PAGER': '/bin/cat', 16:34:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:34:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:52 INFO - 'PWD': '/builds/slave/test', 16:34:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:34:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:34:52 INFO - 'SHELL': '/bin/bash', 16:34:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yKlV9jC6jI/Listeners', 16:34:52 INFO - 'TMPDIR': '/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/', 16:34:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:34:52 INFO - 'USER': 'cltbld', 16:34:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:34:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:34:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:52 INFO - 'XPC_FLAGS': '0x0', 16:34:52 INFO - 'XPC_SERVICE_NAME': '0', 16:34:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:34:52 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/EfFEyO-RThqYztfVPt0FEA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0020', '--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 16:34:52 INFO - mozversion application_buildid: 20170328150822 16:34:52 INFO - mozversion application_changeset: d0f0b8b69e9a826ed266314cf1cfbde8e53438c4 16:34:52 INFO - mozversion application_display_name: Firefox 16:34:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:34:52 INFO - mozversion application_name: Firefox 16:34:52 INFO - mozversion application_remotingname: firefox 16:34:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:34:52 INFO - mozversion application_vendor: Mozilla 16:34:52 INFO - mozversion application_version: 53.0 16:34:52 INFO - mozversion platform_buildid: 20170328150822 16:34:52 INFO - mozversion platform_changeset: d0f0b8b69e9a826ed266314cf1cfbde8e53438c4 16:34:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:34:52 INFO - mozversion platform_version: 53.0 16:34:52 INFO - using testdate: 1490744092 16:34:52 INFO - actual date: 1490744092 16:34:52 INFO - starting webserver on 'localhost:49236' 16:34:52 INFO - SUITE-START | Running 2 tests 16:34:52 INFO - TEST-START | dromaeo_css 16:34:52 INFO - operating with platform_type : mac_ 16:34:52 INFO - Initialising browser for dromaeo_css test... 16:34:52 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmp8VMClF/profile http://localhost:49236/getInfo.html) 16:34:55 INFO - PROCESS | 1633 | 2017-03-28 16:34:55.114 plugin-container[1636:7512] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a4f, name = 'com.apple.tsm.portname' 16:34:55 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:34:55 INFO - PROCESS | 1633 | 2017-03-28 16:34:55.115 plugin-container[1636:7512] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a53, name = 'com.apple.CFPasteboardClient' 16:34:55 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:34:55 INFO - PROCESS | 1633 | 2017-03-28 16:34:55.115 plugin-container[1636:7512] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:34:55 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 16:34:55 INFO - PROCESS | 1633 | colorDepth:24 16:34:55 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 16:34:55 INFO - PROCESS | 1633 | __metrics 16:34:55 ERROR - PROCESS | 1633 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 16:34:55 INFO - TEST-INFO | 1633: exit 0 16:34:55 INFO - Browser initialized. 16:34:55 INFO - Running cycle 1/1 for dromaeo_css test... 16:34:55 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmp8VMClF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:34:58 INFO - PROCESS | 1637 | 2017-03-28 16:34:58.431 plugin-container[1638:7645] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 16:34:58 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:34:58 INFO - PROCESS | 1637 | 2017-03-28 16:34:58.432 plugin-container[1638:7645] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 16:34:58 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:34:58 INFO - PROCESS | 1637 | 2017-03-28 16:34:58.432 plugin-container[1638:7645] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:35:08 INFO - PROCESS | 1637 | RSS: Main: 173072384 16:35:08 INFO - PROCESS | 1637 | 16:38:09 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 16:38:11 INFO - PROCESS | 1637 | RSS: Main: 192024576 16:38:11 INFO - PROCESS | 1637 | 16:41:14 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 16:41:14 INFO - PROCESS | 1637 | RSS: Main: 203743232 16:41:14 INFO - PROCESS | 1637 | 16:44:16 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 16:44:17 INFO - PROCESS | 1637 | RSS: Main: 205393920 16:44:17 INFO - PROCESS | 1637 | 16:47:19 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 16:47:19 INFO - PROCESS | 1637 | RSS: Main: 209821696 16:47:19 INFO - PROCESS | 1637 | 16:50:22 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 16:50:23 INFO - PROCESS | 1637 | RSS: Main: 211189760 16:50:23 INFO - PROCESS | 1637 | 16:53:26 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 16:53:26 INFO - PROCESS | 1637 | RSS: Main: 211435520 16:53:26 INFO - PROCESS | 1637 | 16:53:26 INFO - PROCESS | 1637 | __start_tp_report 16:53:26 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 16:53:26 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 16:53:26 INFO - PROCESS | 1637 | |i|pagename|runs| 16:53:26 INFO - PROCESS | 1637 | |0;dojo.html;2978.7319141277294;3535.5580552430947;3545.663161999609;3551.254236610311;3576.4098923677593;5688.118341657045;5974.372690867456;6011.519078473722;6085.847853803657;6098.908516372258;6050.364711705273;6097.146399504073;6103.755849766015;6108.26700795904;6128.724207410666;5388.541973932211;5431.782728690868;5434.972825135868;5465.043617366965;5553.500184983351;4801.01579176268;5103.464136265694;5362.2224777407255;5373.274607927939;5519.586031047667;5379.220013098098;5381.461853814626;5448.318960129984;5533.03171944908;5550.16747487878;4769.5707386335225;4935.161022626162;5454.481824226692;5481.945180548183;5553.861153471155;5351.384590772033;5428.891422171574;5447.918281225745;5458;5471.835844924659;5832.300123985106;5963.045912653998;6038.426349496791;6125.78559750411;6131.172291740602;6225.066240064027;6242.5942313749465;6247.281562620311;6249.156363890907;6355.586886852339;5387.4612538746205;6430.517711171634;6439.903401448982;6451.451626611743;6464.159659244315;6171.814845554641;6173.81478555644;6201.72092255845;6213.65824879627;6216.44052035319;6317.052442133625;6343.746250149942;6439.356064393617;6445.4199122079235;6500.674966251669;6226.5641405101205;6280.246370435577;6282.465990390777;6294.496440284766;6301.180846489927;6399.840003999937;6401.327860574573;6406.263279722798;6408.807735767934;6435.259945106279;5722.656640601577;5866.120081987736;6212.378762123752;6230.719617617127;6265.248170219603;6322.304546499881;6337.809865704036;6342.968285158637;6348;6375.075614035939;4330.761808100585;5141.305923700327;5163.741812909339;5166.483351664879;5178.300929374562;4479.148961697267;4546.568076032771;4582.473015603182;4641.094986477605;4688.97655511727;6068.362821903725;6111.51107911366;6117.541184411187;6127.80043271483;6128.380904898417;6455.322191169954;6494.318096599884;6506.837329066811;6511.023346497968;6512.990486474604;5944.078667806497;6007.36922623127;6076.483498902554;6122.571420000557;6133.938660613426;4702.811887524461;5644.040513112698;5659;5666.4050274721385;5689.54483641316;6613.768518101843;6638.302978187317;6639.734410623521;6649.468042556584;6654.767083152066;6224.190855188796;6315.715792789244;6319.747210111544;6358.650274234961;6462.450691691259;6643.169603799525;6659.667016649245;6665.766698165541;6666.066750654815;6694.9622808464765;6377.075324078076;6387.105805187184;6394.680265986775;6401.423871851555;6405.839854003687;6256.311805701278;6320.209973753281;6381.489480841428;6437.163168788027;6470.838229044311;6158.076288556752;6201.255849298113;6235;6264.342244064308;6309.968450157719;6251.937480625135;6276.027215781562;6278.089676996901;6283;6296.496280297473;5900.970495147497;6058;6122.4795892347865;6162.784302549389;6209.285932117864;5062.924056139234;6177.907331389943;6178.382161783786;6183.505319574333;6227.283862355887;5049.31834202378;6189.597676151036;6189.96905015472;6213.2233470816145;6234.594751341148 16:53:26 INFO - PROCESS | 1637 | |1;ext.html;468.646172140034;488.98777530561733;521.7756364763152;533.269420893376;601.3642891335566;38857.611423885755;41566.58433415665;41657;41705.37441938366;41706.99999999996;42569.36145957813;43163.56836431635;43220.78389608055;43227.78386108065;43505.7824710876;9494.955554888975;9718.951405242999;9743.123118919295;9752.951235243814;11397.373144477091;10131.341462804894;11112.888871111267;11449.08407327416;11592.536298548048;11605.419729013558;11553.249038812492;11582;11620.767584648302;11628.011619012352;11646.41767911601;11537.596184133557;11568.768624627544;11589.130815188895;11598.478068486938;11609.303441793434;10829.783404331869;11495.19533632646;11504.137189710806;11540.884591154148;11570.710732231677;33871;37717.81141094277;38299.80850095732;38375.42436863449;38396.23207535833;3920.313945059632;4036.8183431745642;4060.533038700558;4098.6516146127615;4153.439285696422;27893.442131157262;28513;28658.570121448196;28914.855425722948;29599.112026639235;3260.2827377976805;3513.771604845677;3546.627604101558;3550.8934731958084;3551.928961420783;371735;521959;522096;523511;526168;58194;58373.70813145992;58386.708066459396;58397.70801146052;58737.706311468166;59817.40182598205;60405.09392359118;60476;60609.393906061254;60792.69603652042;16833.663326733396;17017.82982170187;17047;17070.914645426943;17117.57206069858;11958.461869215906;12292.815607765891;12899.61301160948;13107.082504224803;13205.009624278218;18154.455366339032;18403.53991150232;18512.44462666122;18532.25870965173;18657.81342186561;8075.636596353178;8087.919120808717;8107.554084525408;8120.066192387832;8135.837283254302;882.1972005474987;887.4453466583385;888.440282621944;909.7634615000147;918.7381596245039;28846.84612615472;31025.68974310228;31148.53277200844;31439.899603513768;31476.055718328487;875.7329014650466;955.025873608915;1081.302559848893;1132.4394424759796;1197.9221350612183;11870.821937670942;13707;15646.530604081896;15689.843101569066;16289.104099274653;680548;687273;694087;695800;696241;55090.449095509335;55746.72126639341;55800.72099639476;55819.441805581424;55869;1436.3033928544648;1464.3556834992569;1474.292339676961;1475.6532214929482;1477.6896851661272;27190;28386.006489772757;29248.83004679874;29396.706032939397;29875.701242987292;46570.83572910704;47346.28980565225;47347.28979065248;47393;47394.289085663055;608660;609871;610042;610643;611689;25298.620520691835;26360;27015.189544313704;27110.593341100295;31824.36351273008;36767.264654707295;43424.56575434205;44870.551294486635;45235;47527.287090692975;31435;31633.525497118022;31687.683123169394;32177.35645287128;32183.35633287368;31361.52957705682;31463.685363146076;31799.364012720078;32031.519527206645;32345.353092937537;35997;36462.4530632046;36477;37070.8146459266;37088.44367334438;31037.534436983915;31320.843395782875;31453.528197076605;31725.365492689554;32024.67975320217;23246.76753232446;24841.25476235716;24848.034111756097;24929.750702492744;25227.62158567586 16:53:26 INFO - PROCESS | 1637 | |2;jquery.html;405.2968100345901;405.68559366490985;409.0958980652757;411.6151398442457;434.65444971247854;20258.6961195582;20689.96550172489;21235.57528849426;21445.463863403424;21569.352919412402;21804.781952180514;21875.453113672167;22384.88807555964;22532.774672253272;22616.8869155654;5919.763209471626;6139.539534534928;6242.250929888397;6244.469220116295;6261.06084087386;5067.6452648314635;5999.790007349744;6088.330283668815;6122;6128.96935515324;6014.368491308415;6068.6662233577135;6071.878562428748;6087.878242435148;6092.756289748405;5136.666116702421;5836.546759718846;6099.57302988791;6128.96935515324;6133.570650054498;5264.631475796696;5352.116900711417;5375.22059301403;5384.219288203189;5409.83770486886;21108.472288192763;22155.78143202123;24600.015999360003;26287.68561571933;26450.73549264502;2465.8890349934295;2766.5711814668757;3064.8927287545052;3216.758743094254;3218.983905080483;15249.923750381287;15695.293711782997;15787.605309867346;15855.127967961758;16425.26086326118;1910.7707075150931;1954.4039068084228;1968.8228059474573;1982.2467462364355;1984.7022946558131;131150;133059;135035;136210;158268;12094.879051209551;12135.27188368683;12188.390580470941;12283.815742763865;12290.754184916252;15930.283137258852;16130.193490325437;16156.676866462605;16162.515124546282;16179.271932763055;9042.367034307666;9162.725118246462;9208.539573021457;9225.446473211628;9296.535173241446;7770.611469426506;8538.957305213435;9001.864972025294;9151.313651476166;9176.403533770417;4887.095887260868;4892.804287828518;4903.534164254462;4964.255361695775;5021.271915572222;2098.7061811346425;2133.861299015559;2138.9358319250446;2140.582586395638;2157.967630485544;1031.515187861704;1045.4720366215165;1055.1084333737979;1059.7191744187796;1072.8873468285874;21692.132314707236;21985.23051693183;22003.22988695388;22009;22069.889650551966;1069.641670040545;1081.983770243447;1101.5758932810925;1108.9778204435866;1125.6735546691532;11039.83440248397;11095;11162.162837787198;11261.32432054063;11278;742339;749615;752565;753538;766889.3244270167;153763;162305;163157.55263671055;163319;169282;1029.5109822834243;1032.396048311746;1065.3235195650818;1104.8895110488886;1108.5011744714911;14944.028638138487;19491.805081948998;19931.701024484933;20198.697019545012;20368.59262814765;43488.78255608702;49979;56314.43685563092;60021.39978600333;60299.095513566455;90119.54940225257;90222;90551.54724226336;90974;91493.08506915112;8546.273566746648;8561.957190214009;8614.526201059001;8890;8895.822083558163;12830.037747168813;12911.096223264656;13313.068085233941;13569.1858488491;13726.519571814939;11444.484998174936;11709.707257318636;11813;11816.881831181578;12005.699857503632;9254.305927055633;10445.477726113815;10686.0916822071;10819.67540973772;10864.674059778219;11700.941495292469;11769.764604707687;11835.46740396667;11836.70408239801;11862;8639.179277968582;8866.512341821004;8920.800043969379;8995.235404990388;9064.274858011211;10865.511052002837;11647.355263680254;11913.940430297793;11978.221415607957;11996.40017999114 16:53:26 INFO - PROCESS | 1637 | |3;mootools.html;1297.902657300702;1463.2098666719971;1465.8419848319827;1478.0835881753314;1487.3753023730035;7708.653110610022;7965.641546130423;8238.011438627365;8694;8713.564321783917;8181.100078991321;8327;8495.745127646165;8499;8596.226339629433;2377.2036367816804;2401.111588712179;2407.9157229496973;2413.1795189635523;2414.5291668124723;2147.7100591420194;2226.92205772798;2379.428937055103;2421.5278020785954;2429.1740808125232;2320.373499155227;2374.9168779092734;2398.2805158452484;2407.8675672837985;2415.915442959497;2128.6913397557346;2377.714674239085;2396.101461951768;2397.568437681217;2408.8554686718853;2393.772591603795;2408.337707130536;2424.0303878448585;2424.9272521824196;2426.1993542131054;8419.747407577783;8492.447990880573;8492.957535212347;8509.149085091503;8612.440191387539;5221.39953905302;5264.710440925747;5348.759305831247;5365.678059316453;5376.247325374451;3439.243366459375;3659.414493681025;3703.9444408333898;3705.314516814371;3723.3670276053135;1213.4963989944163;1256.133268045046;1273.8216649669055;1282.160185078775;1304.452130105358;10520.631777887736;10819;10831.187660925383;11130;11134.27627204229;4419.469663640384;4456.398386217884;4643.117807616542;4647.651426143053;4668.183067963093;8721.60752766127;8728.214460698568;8731.912680873236;8739.43193692408;8750.256228220545;5201.427842937273;5220.216967454836;5220.3735551734035;5238.842834714965;5244.239585260192;4706.364640773451;4829.058333624979;4904.0191961607825;4917.827876024322;4918.754062296943;3060.5409188621884;3739.1773809761808;3747.194353214072;3806.7715937043868;3845.057960799566;1115.5664970512853;1145.410113791398;1183.1836033137108;1195.3784032303327;1295.9092863499652;803.236924921327;829.6349606173385;875.0680525240598;926.3654396738256;969.520087556664;4545.795439205178;5231.267622532849;5659.405762394971;5827.271591051119;5966.788350130932;863.4215075899162;958.0323872888293;988.8961659025842;1016.2936758952457;1058.7088550648634;3766.5856755756845;3900.8829735107993;3986.940195897064;3990.7605543667473;4018.959810401917;9808.117269445784;9874.456904870158;10113.29206955506;10114.595416183418;10155.339902906288;9945.30382873192;10065.69802905914;10098.394096354243;10124.139448146843;10158.847617285746;7781.922180778233;7905;7984.9201507985335;8013.078495972921;8085;5613.46672066153;5719.982738865751;5733.426657334233;5859.974504461788;5869.295684517885;8976.86534701967;9216.631334746535;9263.212626926517;9279.257659387098;9369.297302702462;9090.863637045582;9328.626854925727;9368.250539956924;9374.390664606779;9579.568919398504;7235.963820180866;7303.30618591233;7353.154387245321;7387.261273872569;7388.335049845325;7826.530408175528;7850.450468467381;7937.8412431752195;7940.841183176189;7945.1260361361365;5579.6652200868075;6929.85657366549;6942.166939967236;6956.930430695628;7029.507934444539;6855.143107111611;6882.931170688429;6896.586204827727;6957.2694867038235;6974.37230649244;6442.194725659293;6452.451541618827;6548.410643042149;6555.016747487915;6557.180352455943;4314.956850431456;4963.776630051584;4985.1276026695905;5086.313347698014;5201.985612805466;5111.239930437522;5131.461196574306;5150.201718733602;5214.582833373397;5222.817201397933 16:53:26 INFO - PROCESS | 1637 | |4;prototype.html;364.2569158915812;374.11708368250925;379.66399736233427;380.5129434324064;382.0620376974528;4499.730016199031;5292.147748288097;5403.0274550580925;5434.619576629638;5508.584677499945;4304.870853874389;4491.6406687465005;5179.989901969108;5281.366236051679;5434.375046869611;3407.0800883761494;3483.9651603483894;4218.852340168087;4324.567543245666;4355.237833379162;4208.915821683565;4261.850835220768;4272.893177670552;4336.956630433687;4349.173657005159;3904.4728961590104;3948.453247655261;4091.37912947041;4273.38035984782;4274.499417840567;3861.7876016819064;3888.3389823730035;4086.6117718816663;4339.457567804025;4360.607545320905;3403.6596340365763;3560.768550044265;3590.4973303737497;3596.226811235571;3857.556381016191;4666.39336886206;4940.5059494050665;5402.78388864445;5411.891762164774;5415.83752487426;4293.677974151919;4805.318138651479;4859.319695242669;4865.8783530411665;4868.561829435333;5106.948930510722;5626.930883132191;5697.800576979786;5815.331236907768;5879.294484661825;3992.9201415971806;3995;4001.299772539794;4016.297147999118;4026.8858849104163;4380.9780951095045;5834.883302333929;6124.805662895737;6164.599301045418;6203.883301005817;3847.249786291702;4011.956891208307;4040.6565441937764;4060.167665628598;4068.7558746474715;3320.020593924798;3399.2663741491524;4016.819243134066;4061.3907913813164;4087.509498860156;4570.4743954445;4815.590674792612;4830.396200474941;4849.684770489906;4858.441279252931;5332.9733351333;5459.645123067067;5739.942600574024;5893.410658934158;6000.33996260411;1226.675450022203;1264.8102784582202;1275.6159566869865;1327.4491086199312;1338.8460327062319;787.9684812607546;856.9528675922884;904.3759805734022;906.3746015249457;906.8458362078462;4592.586667199968;4592.6555508337005;5228.92156617651;5252.527272545489;5271.05121078202;4976.353074100344;5215.947840521622;5499.9825032368335;5845.415458454206;5860.648361098262;4724.87380678696;4903.523720521114;4964.429090654548;5060;5229.666435059035;2594.6626938497875;2857.3713782967716;3008.533677280025;3046.5277881928337;3070.217094640897;4721.409823772028;5007.8966833929835;5122.410922743932;5126.333576635014;5671.432856714296;4963.6525443218625;5201.373306480279;5229.908036785317;5719.370869204467;6240.00159974411;6303.180586523723;6305.18032655761;6317;6339.657334725727;6340.619562826245;4869.490457958044;4959.851204463872;5770.5095066919785;6079.392060793885;6128.754849805958;4793.952060479351;5904.3210030847;6001.639901605918;6022.698865056817;6046.667433291035;4839;5575.916361254665;6318.704665543461;6346.650934198663;6347.666989932166;3797.2785170817456;3856.749311294757;3995.940060899031;4013.2174226025645;4030.7783071931326;5875.41245875409;5974.372690867396;6041.426064524039;6087.421694938974;6106.687062281453;5672.461116193955;5734.598578099493;5890.9396308664855;5905.232319798399;5940.376260492759;4665.930011049905;5516.310461192351;5747.942520574741;5821.738021788945;5836.708164591669;4737.360456338351;5711.457411545896;5737.397573254915;5771.653700777799;5789.710514474344;5448.727563621724;5809.796657116981;5833.433289352672;5841.415858414124;5863.77807978255;5733.770649173986;5739.684317362585;5762.971185144047;5767.5674324425;5794.246747922743 16:53:26 INFO - PROCESS | 1637 | |5;yui.html;732.4030914804438;732.6702983657356;779.6647441600112;802.8273921106961;859.0328148539842;15148.697026059472;15773.369065237406;16296.59258518536;16425.342986280564;16636.58408539787;14191.574252772407;14299.213543255117;14408.855911440909;14425.206613636272;15048.774268385983;878.7275944457207;885.7829831691245;895.1764376773384;895.5656506594297;896.820635872828;714.4106112457217;737.8524295140967;860.9096044915257;894.472261365794;897.851854444016;895.7536677413731;911.1253196930954;941.6751220828803;944.631593678466;945.5792172483248;935.1163150822475;937.315759495572;938.7230766923774;939.1219210038636;939.7556635274843;671.5668393885965;699.0527834783896;699.1889408286363;700.6251655364356;701.2216439751871;15547.844521554753;15578.221088945507;15898.443554475654;16106.677866442606;16334.591635209095;13517.053806233567;14632.707345853023;14971.07994612154;14998.625034374229;15108.471203507825;9314.86027709585;10131.341462804894;11192.38441885696;11753.647390578297;12008.279503229835;3826.9043273918096;3844.557875844258;3861.710371722132;3889.202713443737;3937.232239713257;97329;97551.02448975561;98911;102151.99999999926;103315;10923.289986150874;11121.833172502418;11433.942830285796;11511.19421640494;11724.472398742077;23010.65484017741;23017.769822301896;23156.7684323158;23175;23284.767152328597;8051.146823225059;8056.436049476481;8247.917520824834;8311.16888311164;8403;4483.103379324149;4510.21071312519;4523.95476045242;4525.637948964075;4546.158960592301;3674.9632503675157;3766.4915236443276;3775.5846856845724;3785.1294202333615;3789.2610940866816;680.2313385873931;685.766839274649;686.8111269400855;709.8757717399434;712.1240873725346;609.5032548472981;704.3660705365212;712.5984641081692;725.5501589014845;728.3153835394712;10211.655234594053;10470.319429237075;10600;10712.303700259457;10825.945870270756;566.7676252736359;576.20771439271;580.1327016110941;595.6158277910723;595.8659301657093;4713.34013238147;4798.856034318976;4988.301637770715;5080.669756465818;5171.741412929338;102064;104397;104895;105864.9413505855;106179;72790.908136378;89814;91102.08897910937;93817.53091234637;94915.52542237245;71419.64290178516;78687;80157.19842801614;82299.7655035175;83349.58325208335;9926.702198934043;9951.402915825074;9955.950220248853;9995.100440960348;10011.099001089937;52880.67798305073;53331.93336133178;53876;53929.19106213489;54806.72596637151;68514.65742671255;69389;69920;72177.27822721915;72255.63872180606;12134.939325303318;12162;12245.816312755138;12622.116451848282;12694.682632934251;13088.411021504246;13176.209427434385;13274.336283185996;13495.865041349462;13992;12289.324087175291;12328.383580820744;12684.619461416172;12691.42888570035;13113;12008.519659213884;12208.877911220774;12269.57056503018;12303.507859685513;12604.49582016709;11703.707407314885;12194;12222.572209972608;12377.752444950871;12638.568790351126;8810;8915.242204412698;9308.813823723352;9317.44095354281;9623.711288661352;7891.565963872042;9001.02149097999;10286.897131028893;10312;10413.375197488174 16:53:26 INFO - PROCESS | 1637 | __end_tp_report 16:53:26 INFO - PROCESS | 1637 | __start_cc_report 16:53:26 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,363 16:53:26 INFO - PROCESS | 1637 | __end_cc_report 16:53:26 INFO - PROCESS | 1637 | __startTimestamp1490745206289__endTimestamp 16:53:26 INFO - PROCESS | 1637 | 16:53:26 INFO - PROCESS | 1637 | ------- Summary: start ------- 16:53:26 INFO - PROCESS | 1637 | Number of tests: 6 16:53:26 INFO - PROCESS | 1637 | 16:53:26 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5915.35 Median:6177.91 stddev:682.62 (11.0%) stddev-sans-first:644.67 16:53:26 INFO - PROCESS | 1637 | Values: 2978.7 3535.6 3545.7 3551.3 3576.4 5688.1 5974.4 6011.5 6085.8 6098.9 6050.4 6097.1 6103.8 6108.3 6128.7 5388.5 5431.8 5435.0 5465.0 5553.5 4801.0 5103.5 5362.2 5373.3 5519.6 5379.2 5381.5 5448.3 5533.0 5550.2 4769.6 4935.2 5454.5 5481.9 5553.9 5351.4 5428.9 5447.9 5458.0 5471.8 5832.3 5963.0 6038.4 6125.8 6131.2 6225.1 6242.6 6247.3 6249.2 6355.6 5387.5 6430.5 6439.9 6451.5 6464.2 6171.8 6173.8 6201.7 6213.7 6216.4 6317.1 6343.7 6439.4 6445.4 6500.7 6226.6 6280.2 6282.5 6294.5 6301.2 6399.8 6401.3 6406.3 6408.8 6435.3 5722.7 5866.1 6212.4 6230.7 6265.2 6322.3 6337.8 6343.0 6348.0 6375.1 4330.8 5141.3 5163.7 5166.5 5178.3 4479.1 4546.6 4582.5 4641.1 4689.0 6068.4 6111.5 6117.5 6127.8 6128.4 6455.3 6494.3 6506.8 6511.0 6513.0 5944.1 6007.4 6076.5 6122.6 6133.9 4702.8 5644.0 5659.0 5666.4 5689.5 6613.8 6638.3 6639.7 6649.5 6654.8 6224.2 6315.7 6319.7 6358.7 6462.5 6643.2 6659.7 6665.8 6666.1 6695.0 6377.1 6387.1 6394.7 6401.4 6405.8 6256.3 6320.2 6381.5 6437.2 6470.8 6158.1 6201.3 6235.0 6264.3 6310.0 6251.9 6276.0 6278.1 6283.0 6296.5 5901.0 6058.0 6122.5 6162.8 6209.3 5062.9 6177.9 6178.4 6183.5 6227.3 5049.3 6189.6 6190.0 6213.2 6234.6 16:53:26 INFO - PROCESS | 1637 | 16:53:26 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:71980.15 Median:18692.39 stddev:161968.38 (866.5%) stddev-sans-first:162333.75 16:53:26 INFO - PROCESS | 1637 | Values: 468.6 489.0 521.8 533.3 601.4 38857.6 41566.6 41657.0 41705.4 41707.0 42569.4 43163.6 43220.8 43227.8 43505.8 9495.0 9719.0 9743.1 9753.0 11397.4 10131.3 11112.9 11449.1 11592.5 11605.4 11553.2 11582.0 11620.8 11628.0 11646.4 11537.6 11568.8 11589.1 11598.5 11609.3 10829.8 11495.2 11504.1 11540.9 11570.7 33871.0 37717.8 38299.8 38375.4 38396.2 3920.3 4036.8 4060.5 4098.7 4153.4 27893.4 28513.0 28658.6 28914.9 29599.1 3260.3 3513.8 3546.6 3550.9 3551.9 371735.0 521959.0 522096.0 523511.0 526168.0 58194.0 58373.7 58386.7 58397.7 58737.7 59817.4 60405.1 60476.0 60609.4 60792.7 16833.7 17017.8 17047.0 17070.9 17117.6 11958.5 12292.8 12899.6 13107.1 13205.0 18154.5 18403.5 18512.4 18532.3 18657.8 8075.6 8087.9 8107.6 8120.1 8135.8 882.2 887.4 888.4 909.8 918.7 28846.8 31025.7 31148.5 31439.9 31476.1 875.7 955.0 1081.3 1132.4 1197.9 11870.8 13707.0 15646.5 15689.8 16289.1 680548.0 687273.0 694087.0 695800.0 696241.0 55090.4 55746.7 55800.7 55819.4 55869.0 1436.3 1464.4 1474.3 1475.7 1477.7 27190.0 28386.0 29248.8 29396.7 29875.7 46570.8 47346.3 47347.3 47393.0 47394.3 608660.0 609871.0 610042.0 610643.0 611689.0 25298.6 26360.0 27015.2 27110.6 31824.4 36767.3 43424.6 44870.6 45235.0 47527.3 31435.0 31633.5 31687.7 32177.4 32183.4 31361.5 31463.7 31799.4 32031.5 32345.4 35997.0 36462.5 36477.0 37070.8 37088.4 31037.5 31320.8 31453.5 31725.4 32024.7 23246.8 24841.3 24848.0 24929.8 25227.6 16:53:26 INFO - PROCESS | 1637 | 16:53:26 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:41716.44 Median:21748.46 stddev:125705.92 (578.0%) stddev-sans-first:126020.28 16:53:26 INFO - PROCESS | 1637 | Values: 405.3 405.7 409.1 411.6 434.7 20258.7 20690.0 21235.6 21445.5 21569.4 21804.8 21875.5 22384.9 22532.8 22616.9 5919.8 6139.5 6242.3 6244.5 6261.1 5067.6 5999.8 6088.3 6122.0 6129.0 6014.4 6068.7 6071.9 6087.9 6092.8 5136.7 5836.5 6099.6 6129.0 6133.6 5264.6 5352.1 5375.2 5384.2 5409.8 21108.5 22155.8 24600.0 26287.7 26450.7 2465.9 2766.6 3064.9 3216.8 3219.0 15249.9 15695.3 15787.6 15855.1 16425.3 1910.8 1954.4 1968.8 1982.2 1984.7 131150.0 133059.0 135035.0 136210.0 158268.0 12094.9 12135.3 12188.4 12283.8 12290.8 15930.3 16130.2 16156.7 16162.5 16179.3 9042.4 9162.7 9208.5 9225.4 9296.5 7770.6 8539.0 9001.9 9151.3 9176.4 4887.1 4892.8 4903.5 4964.3 5021.3 2098.7 2133.9 2138.9 2140.6 2158.0 1031.5 1045.5 1055.1 1059.7 1072.9 21692.1 21985.2 22003.2 22009.0 22069.9 1069.6 1082.0 1101.6 1109.0 1125.7 11039.8 11095.0 11162.2 11261.3 11278.0 742339.0 749615.0 752565.0 753538.0 766889.3 153763.0 162305.0 163157.6 163319.0 169282.0 1029.5 1032.4 1065.3 1104.9 1108.5 14944.0 19491.8 19931.7 20198.7 20368.6 43488.8 49979.0 56314.4 60021.4 60299.1 90119.5 90222.0 90551.5 90974.0 91493.1 8546.3 8562.0 8614.5 8890.0 8895.8 12830.0 12911.1 13313.1 13569.2 13726.5 11444.5 11709.7 11813.0 11816.9 12005.7 9254.3 10445.5 10686.1 10819.7 10864.7 11700.9 11769.8 11835.5 11836.7 11862.0 8639.2 8866.5 8920.8 8995.2 9064.3 10865.5 11647.4 11913.9 11978.2 11996.4 16:53:26 INFO - PROCESS | 1637 | 16:53:26 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5468.01 Median:5220.30 stddev:2944.42 (56.4%) stddev-sans-first:2936.00 16:53:26 INFO - PROCESS | 1637 | Values: 1297.9 1463.2 1465.8 1478.1 1487.4 7708.7 7965.6 8238.0 8694.0 8713.6 8181.1 8327.0 8495.7 8499.0 8596.2 2377.2 2401.1 2407.9 2413.2 2414.5 2147.7 2226.9 2379.4 2421.5 2429.2 2320.4 2374.9 2398.3 2407.9 2415.9 2128.7 2377.7 2396.1 2397.6 2408.9 2393.8 2408.3 2424.0 2424.9 2426.2 8419.7 8492.4 8493.0 8509.1 8612.4 5221.4 5264.7 5348.8 5365.7 5376.2 3439.2 3659.4 3703.9 3705.3 3723.4 1213.5 1256.1 1273.8 1282.2 1304.5 10520.6 10819.0 10831.2 11130.0 11134.3 4419.5 4456.4 4643.1 4647.7 4668.2 8721.6 8728.2 8731.9 8739.4 8750.3 5201.4 5220.2 5220.4 5238.8 5244.2 4706.4 4829.1 4904.0 4917.8 4918.8 3060.5 3739.2 3747.2 3806.8 3845.1 1115.6 1145.4 1183.2 1195.4 1295.9 803.2 829.6 875.1 926.4 969.5 4545.8 5231.3 5659.4 5827.3 5966.8 863.4 958.0 988.9 1016.3 1058.7 3766.6 3900.9 3986.9 3990.8 4019.0 9808.1 9874.5 10113.3 10114.6 10155.3 9945.3 10065.7 10098.4 10124.1 10158.8 7781.9 7905.0 7984.9 8013.1 8085.0 5613.5 5720.0 5733.4 5860.0 5869.3 8976.9 9216.6 9263.2 9279.3 9369.3 9090.9 9328.6 9368.3 9374.4 9579.6 7236.0 7303.3 7353.2 7387.3 7388.3 7826.5 7850.5 7937.8 7940.8 7945.1 5579.7 6929.9 6942.2 6956.9 7029.5 6855.1 6882.9 6896.6 6957.3 6974.4 6442.2 6452.5 6548.4 6555.0 6557.2 4315.0 4963.8 4985.1 5086.3 5202.0 5111.2 5131.5 5150.2 5214.6 5222.8 16:53:26 INFO - PROCESS | 1637 | 16:53:26 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4642.73 Median:5033.95 stddev:1438.26 (28.6%) stddev-sans-first:1405.99 16:53:26 INFO - PROCESS | 1637 | Values: 364.3 374.1 379.7 380.5 382.1 4499.7 5292.1 5403.0 5434.6 5508.6 4304.9 4491.6 5180.0 5281.4 5434.4 3407.1 3484.0 4218.9 4324.6 4355.2 4208.9 4261.9 4272.9 4337.0 4349.2 3904.5 3948.5 4091.4 4273.4 4274.5 3861.8 3888.3 4086.6 4339.5 4360.6 3403.7 3560.8 3590.5 3596.2 3857.6 4666.4 4940.5 5402.8 5411.9 5415.8 4293.7 4805.3 4859.3 4865.9 4868.6 5106.9 5626.9 5697.8 5815.3 5879.3 3992.9 3995.0 4001.3 4016.3 4026.9 4381.0 5834.9 6124.8 6164.6 6203.9 3847.2 4012.0 4040.7 4060.2 4068.8 3320.0 3399.3 4016.8 4061.4 4087.5 4570.5 4815.6 4830.4 4849.7 4858.4 5333.0 5459.6 5739.9 5893.4 6000.3 1226.7 1264.8 1275.6 1327.4 1338.8 788.0 857.0 904.4 906.4 906.8 4592.6 4592.7 5228.9 5252.5 5271.1 4976.4 5215.9 5500.0 5845.4 5860.6 4724.9 4903.5 4964.4 5060.0 5229.7 2594.7 2857.4 3008.5 3046.5 3070.2 4721.4 5007.9 5122.4 5126.3 5671.4 4963.7 5201.4 5229.9 5719.4 6240.0 6303.2 6305.2 6317.0 6339.7 6340.6 4869.5 4959.9 5770.5 6079.4 6128.8 4794.0 5904.3 6001.6 6022.7 6046.7 4839.0 5575.9 6318.7 6346.7 6347.7 3797.3 3856.7 3995.9 4013.2 4030.8 5875.4 5974.4 6041.4 6087.4 6106.7 5672.5 5734.6 5890.9 5905.2 5940.4 4665.9 5516.3 5747.9 5821.7 5836.7 4737.4 5711.5 5737.4 5771.7 5789.7 5448.7 5809.8 5833.4 5841.4 5863.8 5733.8 5739.7 5763.0 5767.6 5794.2 16:53:26 INFO - PROCESS | 1637 | 16:53:26 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:20483.13 Median:4756.10 stddev:29387.75 (617.9%) stddev-sans-first:29432.77 16:53:26 INFO - PROCESS | 1637 | Values: 732.4 732.7 779.7 802.8 859.0 15148.7 15773.4 16296.6 16425.3 16636.6 14191.6 14299.2 14408.9 14425.2 15048.8 878.7 885.8 895.2 895.6 896.8 714.4 737.9 860.9 894.5 897.9 895.8 911.1 941.7 944.6 945.6 935.1 937.3 938.7 939.1 939.8 671.6 699.1 699.2 700.6 701.2 15547.8 15578.2 15898.4 16106.7 16334.6 13517.1 14632.7 14971.1 14998.6 15108.5 9314.9 10131.3 11192.4 11753.6 12008.3 3826.9 3844.6 3861.7 3889.2 3937.2 97329.0 97551.0 98911.0 102152.0 103315.0 10923.3 11121.8 11433.9 11511.2 11724.5 23010.7 23017.8 23156.8 23175.0 23284.8 8051.1 8056.4 8247.9 8311.2 8403.0 4483.1 4510.2 4524.0 4525.6 4546.2 3675.0 3766.5 3775.6 3785.1 3789.3 680.2 685.8 686.8 709.9 712.1 609.5 704.4 712.6 725.6 728.3 10211.7 10470.3 10600.0 10712.3 10825.9 566.8 576.2 580.1 595.6 595.9 4713.3 4798.9 4988.3 5080.7 5171.7 102064.0 104397.0 104895.0 105864.9 106179.0 72790.9 89814.0 91102.1 93817.5 94915.5 71419.6 78687.0 80157.2 82299.8 83349.6 9926.7 9951.4 9956.0 9995.1 10011.1 52880.7 53331.9 53876.0 53929.2 54806.7 68514.7 69389.0 69920.0 72177.3 72255.6 12134.9 12162.0 12245.8 12622.1 12694.7 13088.4 13176.2 13274.3 13495.9 13992.0 12289.3 12328.4 12684.6 12691.4 13113.0 12008.5 12208.9 12269.6 12303.5 12604.5 11703.7 12194.0 12222.6 12377.8 12638.6 8810.0 8915.2 9308.8 9317.4 9623.7 7891.6 9001.0 10286.9 10312.0 10413.4 16:53:26 INFO - PROCESS | 1637 | -------- Summary: end -------- 16:53:26 INFO - PROCESS | 1637 | 16:53:26 INFO - TEST-INFO | 1637: exit 0 16:53:26 INFO - TEST-OK | dromaeo_css | took 1114672ms 16:53:26 INFO - TEST-START | kraken 16:53:26 INFO - operating with platform_type : mac_ 16:53:26 INFO - Initialising browser for kraken test... 16:53:26 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpmyClHs/profile http://localhost:49236/getInfo.html) 16:53:29 INFO - PROCESS | 1651 | 2017-03-28 16:53:29.589 plugin-container[1653:10044] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8443, name = 'com.apple.tsm.portname' 16:53:29 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:53:29 INFO - PROCESS | 1651 | 2017-03-28 16:53:29.589 plugin-container[1653:10044] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8623, name = 'com.apple.CFPasteboardClient' 16:53:29 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:53:29 INFO - PROCESS | 1651 | 2017-03-28 16:53:29.589 plugin-container[1653:10044] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:53:29 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 16:53:29 INFO - PROCESS | 1651 | colorDepth:24 16:53:29 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 16:53:29 INFO - PROCESS | 1651 | __metrics 16:53:29 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 16:53:30 INFO - TEST-INFO | 1651: exit 0 16:53:30 INFO - Browser initialized. 16:53:30 INFO - Running cycle 1/1 for kraken test... 16:53:30 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/T/tmpmyClHs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:53:32 INFO - PROCESS | 1654 | 2017-03-28 16:53:32.842 plugin-container[1655:10173] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x833f, name = 'com.apple.tsm.portname' 16:53:32 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:53:32 INFO - PROCESS | 1654 | 2017-03-28 16:53:32.842 plugin-container[1655:10173] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x461b, name = 'com.apple.CFPasteboardClient' 16:53:32 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:53:32 INFO - PROCESS | 1654 | 2017-03-28 16:53:32.842 plugin-container[1655:10173] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:53:42 INFO - PROCESS | 1654 | RSS: Main: 173174784 16:53:42 INFO - PROCESS | 1654 | 16:53:45 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 16:53:46 INFO - PROCESS | 1654 | RSS: Main: 185909248 16:53:46 INFO - PROCESS | 1654 | 16:53:48 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 16:53:49 INFO - PROCESS | 1654 | RSS: Main: 193802240 16:53:49 INFO - PROCESS | 1654 | 16:53:52 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 16:53:53 INFO - PROCESS | 1654 | RSS: Main: 197554176 16:53:53 INFO - PROCESS | 1654 | 16:53:55 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 16:53:56 INFO - PROCESS | 1654 | RSS: Main: 198942720 16:53:56 INFO - PROCESS | 1654 | 16:53:58 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:53:58 INFO - PROCESS | 1654 | RSS: Main: 199159808 16:53:58 INFO - PROCESS | 1654 | 16:54:01 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 16:54:02 INFO - PROCESS | 1654 | RSS: Main: 203587584 16:54:02 INFO - PROCESS | 1654 | 16:54:05 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 16:54:05 INFO - PROCESS | 1654 | RSS: Main: 203689984 16:54:05 INFO - PROCESS | 1654 | 16:54:08 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 16:54:09 INFO - PROCESS | 1654 | RSS: Main: 203173888 16:54:09 INFO - PROCESS | 1654 | 16:54:10 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:54:11 INFO - PROCESS | 1654 | RSS: Main: 202313728 16:54:11 INFO - PROCESS | 1654 | 16:54:13 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:54:14 INFO - PROCESS | 1654 | RSS: Main: 202473472 16:54:14 INFO - PROCESS | 1654 | 16:54:16 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:54:16 INFO - PROCESS | 1654 | RSS: Main: 202305536 16:54:16 INFO - PROCESS | 1654 | 16:54:19 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:54:20 INFO - PROCESS | 1654 | RSS: Main: 202276864 16:54:20 INFO - PROCESS | 1654 | 16:54:23 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:54:23 INFO - PROCESS | 1654 | RSS: Main: 202670080 16:54:23 INFO - PROCESS | 1654 | 16:54:25 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 16:54:25 INFO - PROCESS | 1654 | RSS: Main: 204640256 16:54:25 INFO - PROCESS | 1654 | 16:54:25 INFO - PROCESS | 1654 | __start_tp_report 16:54:25 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 16:54:25 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 16:54:25 INFO - PROCESS | 1654 | |i|pagename|runs| 16:54:25 INFO - PROCESS | 1654 | |0;ai-astar;117;176;126;118;118;118;120;118;119;118 16:54:25 INFO - PROCESS | 1654 | |1;audio-beat-detection;135;123;114;145;111;111;110;110;141;141 16:54:25 INFO - PROCESS | 1654 | |2;audio-dft;200;191;195;195;193;198;198;225;263;192 16:54:25 INFO - PROCESS | 1654 | |3;audio-fft;82;58;59;86;61;59;60;52;87;84 16:54:25 INFO - PROCESS | 1654 | |4;audio-oscillator;95;101;102;70;71;69;86;59;89;112 16:54:25 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;90;87;90;88;91;85;90;94;89;88 16:54:25 INFO - PROCESS | 1654 | |6;imaging-darkroom;97;115;128;101;99;98;99;148;98;99 16:54:25 INFO - PROCESS | 1654 | |7;imaging-desaturate;91;96;101;92;95;93;92;93;92;93 16:54:25 INFO - PROCESS | 1654 | |8;json-parse-financial;58;58;57;59;60;62;61;62;62;62 16:54:25 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;65;73;71;85;75;75;68;71;71;70 16:54:25 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;85;75;88;72;73;72;92;103;102;105 16:54:25 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;133;157;135;133;139;153;159;148;178;135 16:54:25 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;169;190;164;221;225;173;155;144;146;204 16:54:25 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;64;67;65;66;81;57;60;67;85;89 16:54:25 INFO - PROCESS | 1654 | __end_tp_report 16:54:25 INFO - PROCESS | 1654 | __start_cc_report 16:54:25 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,943 16:54:25 INFO - PROCESS | 1654 | __end_cc_report 16:54:25 INFO - PROCESS | 1654 | __startTimestamp1490745265961__endTimestamp 16:54:25 INFO - PROCESS | 1654 | 16:54:25 INFO - PROCESS | 1654 | ------- Summary: start ------- 16:54:25 INFO - PROCESS | 1654 | Number of tests: 14 16:54:25 INFO - PROCESS | 1654 | 16:54:25 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:124.80 Median:118.50 stddev:18.17 (15.3%) stddev-sans-first:19.05 16:54:25 INFO - PROCESS | 1654 | Values: 117.0 176.0 126.0 118.0 118.0 118.0 120.0 118.0 119.0 118.0 16:54:25 INFO - PROCESS | 1654 | 16:54:25 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:124.10 Median:129.00 stddev:14.80 (11.5%) stddev-sans-first:15.16 16:54:25 INFO - PROCESS | 1654 | Values: 135.0 123.0 114.0 145.0 111.0 111.0 110.0 110.0 141.0 141.0 16:54:25 INFO - PROCESS | 1654 | 16:54:25 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:205.00 Median:198.00 stddev:22.60 (11.4%) stddev-sans-first:23.90 16:54:25 INFO - PROCESS | 1654 | Values: 200.0 191.0 195.0 195.0 193.0 198.0 198.0 225.0 263.0 192.0 16:54:25 INFO - PROCESS | 1654 | 16:54:25 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:68.80 Median:71.50 stddev:13.99 (19.6%) stddev-sans-first:14.00 16:54:25 INFO - PROCESS | 1654 | Values: 82.0 58.0 59.0 86.0 61.0 59.0 60.0 52.0 87.0 84.0 16:54:25 INFO - PROCESS | 1654 | 16:54:25 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:85.40 Median:70.50 stddev:17.46 (24.8%) stddev-sans-first:18.17 16:54:25 INFO - PROCESS | 1654 | Values: 95.0 101.0 102.0 70.0 71.0 69.0 86.0 59.0 89.0 112.0 16:54:25 INFO - PROCESS | 1654 | 16:54:25 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:89.20 Median:90.00 stddev:2.44 (2.7%) stddev-sans-first:2.57 16:54:25 INFO - PROCESS | 1654 | Values: 90.0 87.0 90.0 88.0 91.0 85.0 90.0 94.0 89.0 88.0 16:54:25 INFO - PROCESS | 1654 | 16:54:25 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:108.20 Median:98.00 stddev:17.20 (17.5%) stddev-sans-first:17.76 16:54:25 INFO - PROCESS | 1654 | Values: 97.0 115.0 128.0 101.0 99.0 98.0 99.0 148.0 98.0 99.0 16:54:25 INFO - PROCESS | 1654 | 16:54:25 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:93.00 stddev:2.94 (3.2%) stddev-sans-first:2.93 16:54:25 INFO - PROCESS | 1654 | Values: 91.0 96.0 101.0 92.0 95.0 93.0 92.0 93.0 92.0 93.0 16:54:25 INFO - PROCESS | 1654 | 16:54:25 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:61.50 stddev:1.97 (3.2%) stddev-sans-first:1.94 16:54:25 INFO - PROCESS | 1654 | Values: 58.0 58.0 57.0 59.0 60.0 62.0 61.0 62.0 62.0 62.0 16:54:25 INFO - PROCESS | 1654 | 16:54:25 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:72.40 Median:72.00 stddev:5.36 (7.4%) stddev-sans-first:4.97 16:54:25 INFO - PROCESS | 1654 | Values: 65.0 73.0 71.0 85.0 75.0 75.0 68.0 71.0 71.0 70.0 16:54:25 INFO - PROCESS | 1654 | 16:54:25 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:74.00 stddev:13.43 (18.2%) stddev-sans-first:14.23 16:54:25 INFO - PROCESS | 1654 | Values: 85.0 75.0 88.0 72.0 73.0 72.0 92.0 103.0 102.0 105.0 16:54:25 INFO - PROCESS | 1654 | 16:54:25 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:147.00 Median:150.50 stddev:14.85 (9.9%) stddev-sans-first:14.87 16:54:25 INFO - PROCESS | 1654 | Values: 133.0 157.0 135.0 133.0 139.0 153.0 159.0 148.0 178.0 135.0 16:54:25 INFO - PROCESS | 1654 | 16:54:25 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.10 Median:181.50 stddev:29.58 (16.3%) stddev-sans-first:31.15 16:54:25 INFO - PROCESS | 1654 | Values: 169.0 190.0 164.0 221.0 225.0 173.0 155.0 144.0 146.0 204.0 16:54:25 INFO - PROCESS | 1654 | 16:54:25 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:67.00 stddev:10.91 (16.3%) stddev-sans-first:11.34 16:54:25 INFO - PROCESS | 1654 | Values: 64.0 67.0 65.0 66.0 81.0 57.0 60.0 67.0 85.0 89.0 16:54:25 INFO - PROCESS | 1654 | -------- Summary: end -------- 16:54:25 INFO - PROCESS | 1654 | 16:54:26 INFO - TEST-INFO | 1654: exit 0 16:54:26 INFO - TEST-OK | kraken | took 59944ms 16:54:26 INFO - SUITE-END | took 1174s 16:54:27 INFO - Completed test suite (00:19:34) 16:54:27 INFO - javascript benchmark 16:54:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7466.543196081138, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2978.7319141277294, 3535.5580552430947, 3545.663161999609, 3551.254236610311, 3576.4098923677593, 5688.118341657045, 5974.372690867456, 6011.519078473722, 6085.847853803657, 6098.908516372258, 6050.364711705273, 6097.146399504073, 6103.755849766015, 6108.26700795904, 6128.724207410666, 5388.541973932211, 5431.782728690868, 5434.972825135868, 5465.043617366965, 5553.500184983351, 4801.01579176268, 5103.464136265694, 5362.2224777407255, 5373.274607927939, 5519.586031047667, 5379.220013098098, 5381.461853814626, 5448.318960129984, 5533.03171944908, 5550.16747487878, 4769.5707386335225, 4935.161022626162, 5454.481824226692, 5481.945180548183, 5553.861153471155, 5351.384590772033, 5428.891422171574, 5447.918281225745, 5458.0, 5471.835844924659, 5832.300123985106, 5963.045912653998, 6038.426349496791, 6125.78559750411, 6131.172291740602, 6225.066240064027, 6242.5942313749465, 6247.281562620311, 6249.156363890907, 6355.586886852339, 5387.4612538746205, 6430.517711171634, 6439.903401448982, 6451.451626611743, 6464.159659244315, 6171.814845554641, 6173.81478555644, 6201.72092255845, 6213.65824879627, 6216.44052035319, 6317.052442133625, 6343.746250149942, 6439.356064393617, 6445.4199122079235, 6500.674966251669, 6226.5641405101205, 6280.246370435577, 6282.465990390777, 6294.496440284766, 6301.180846489927, 6399.840003999937, 6401.327860574573, 6406.263279722798, 6408.807735767934, 6435.259945106279, 5722.656640601577, 5866.120081987736, 6212.378762123752, 6230.719617617127, 6265.248170219603, 6322.304546499881, 6337.809865704036, 6342.968285158637, 6348.0, 6375.075614035939, 4330.761808100585, 5141.305923700327, 5163.741812909339, 5166.483351664879, 5178.300929374562, 4479.148961697267, 4546.568076032771, 4582.473015603182, 4641.094986477605, 4688.97655511727, 6068.362821903725, 6111.51107911366, 6117.541184411187, 6127.80043271483, 6128.380904898417, 6455.322191169954, 6494.318096599884, 6506.837329066811, 6511.023346497968, 6512.990486474604, 5944.078667806497, 6007.36922623127, 6076.483498902554, 6122.571420000557, 6133.938660613426, 4702.811887524461, 5644.040513112698, 5659.0, 5666.4050274721385, 5689.54483641316, 6613.768518101843, 6638.302978187317, 6639.734410623521, 6649.468042556584, 6654.767083152066, 6224.190855188796, 6315.715792789244, 6319.747210111544, 6358.650274234961, 6462.450691691259, 6643.169603799525, 6659.667016649245, 6665.766698165541, 6666.066750654815, 6694.9622808464765, 6377.075324078076, 6387.105805187184, 6394.680265986775, 6401.423871851555, 6405.839854003687, 6256.311805701278, 6320.209973753281, 6381.489480841428, 6437.163168788027, 6470.838229044311, 6158.076288556752, 6201.255849298113, 6235.0, 6264.342244064308, 6309.968450157719, 6251.937480625135, 6276.027215781562, 6278.089676996901, 6283.0, 6296.496280297473, 5900.970495147497, 6058.0, 6122.4795892347865, 6162.784302549389, 6209.285932117864, 5062.924056139234, 6177.907331389943, 6178.382161783786, 6183.505319574333, 6227.283862355887, 5049.31834202378, 6189.597676151036, 6189.96905015472, 6213.2233470816145, 6234.594751341148], "value": 5872.117080353338, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [468.646172140034, 488.98777530561733, 521.7756364763152, 533.269420893376, 601.3642891335566, 38857.611423885755, 41566.58433415665, 41657.0, 41705.37441938366, 41706.99999999996, 42569.36145957813, 43163.56836431635, 43220.78389608055, 43227.78386108065, 43505.7824710876, 9494.955554888975, 9718.951405242999, 9743.123118919295, 9752.951235243814, 11397.373144477091, 10131.341462804894, 11112.888871111267, 11449.08407327416, 11592.536298548048, 11605.419729013558, 11553.249038812492, 11582.0, 11620.767584648302, 11628.011619012352, 11646.41767911601, 11537.596184133557, 11568.768624627544, 11589.130815188895, 11598.478068486938, 11609.303441793434, 10829.783404331869, 11495.19533632646, 11504.137189710806, 11540.884591154148, 11570.710732231677, 33871.0, 37717.81141094277, 38299.80850095732, 38375.42436863449, 38396.23207535833, 3920.313945059632, 4036.8183431745642, 4060.533038700558, 4098.6516146127615, 4153.439285696422, 27893.442131157262, 28513.0, 28658.570121448196, 28914.855425722948, 29599.112026639235, 3260.2827377976805, 3513.771604845677, 3546.627604101558, 3550.8934731958084, 3551.928961420783, 371735.0, 521959.0, 522096.0, 523511.0, 526168.0, 58194.0, 58373.70813145992, 58386.708066459396, 58397.70801146052, 58737.706311468166, 59817.40182598205, 60405.09392359118, 60476.0, 60609.393906061254, 60792.69603652042, 16833.663326733396, 17017.82982170187, 17047.0, 17070.914645426943, 17117.57206069858, 11958.461869215906, 12292.815607765891, 12899.61301160948, 13107.082504224803, 13205.009624278218, 18154.455366339032, 18403.53991150232, 18512.44462666122, 18532.25870965173, 18657.81342186561, 8075.636596353178, 8087.919120808717, 8107.554084525408, 8120.066192387832, 8135.837283254302, 882.1972005474987, 887.4453466583385, 888.440282621944, 909.7634615000147, 918.7381596245039, 28846.84612615472, 31025.68974310228, 31148.53277200844, 31439.899603513768, 31476.055718328487, 875.7329014650466, 955.025873608915, 1081.302559848893, 1132.4394424759796, 1197.9221350612183, 11870.821937670942, 13707.0, 15646.530604081896, 15689.843101569066, 16289.104099274653, 680548.0, 687273.0, 694087.0, 695800.0, 696241.0, 55090.449095509335, 55746.72126639341, 55800.72099639476, 55819.441805581424, 55869.0, 1436.3033928544648, 1464.3556834992569, 1474.292339676961, 1475.6532214929482, 1477.6896851661272, 27190.0, 28386.006489772757, 29248.83004679874, 29396.706032939397, 29875.701242987292, 46570.83572910704, 47346.28980565225, 47347.28979065248, 47393.0, 47394.289085663055, 608660.0, 609871.0, 610042.0, 610643.0, 611689.0, 25298.620520691835, 26360.0, 27015.189544313704, 27110.593341100295, 31824.36351273008, 36767.264654707295, 43424.56575434205, 44870.551294486635, 45235.0, 47527.287090692975, 31435.0, 31633.525497118022, 31687.683123169394, 32177.35645287128, 32183.35633287368, 31361.52957705682, 31463.685363146076, 31799.364012720078, 32031.519527206645, 32345.353092937537, 35997.0, 36462.4530632046, 36477.0, 37070.8146459266, 37088.44367334438, 31037.534436983915, 31320.843395782875, 31453.528197076605, 31725.365492689554, 32024.67975320217, 23246.76753232446, 24841.25476235716, 24848.034111756097, 24929.750702492744, 25227.62158567586], "value": 20168.760299622772, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.2968100345901, 405.68559366490985, 409.0958980652757, 411.6151398442457, 434.65444971247854, 20258.6961195582, 20689.96550172489, 21235.57528849426, 21445.463863403424, 21569.352919412402, 21804.781952180514, 21875.453113672167, 22384.88807555964, 22532.774672253272, 22616.8869155654, 5919.763209471626, 6139.539534534928, 6242.250929888397, 6244.469220116295, 6261.06084087386, 5067.6452648314635, 5999.790007349744, 6088.330283668815, 6122.0, 6128.96935515324, 6014.368491308415, 6068.6662233577135, 6071.878562428748, 6087.878242435148, 6092.756289748405, 5136.666116702421, 5836.546759718846, 6099.57302988791, 6128.96935515324, 6133.570650054498, 5264.631475796696, 5352.116900711417, 5375.22059301403, 5384.219288203189, 5409.83770486886, 21108.472288192763, 22155.78143202123, 24600.015999360003, 26287.68561571933, 26450.73549264502, 2465.8890349934295, 2766.5711814668757, 3064.8927287545052, 3216.758743094254, 3218.983905080483, 15249.923750381287, 15695.293711782997, 15787.605309867346, 15855.127967961758, 16425.26086326118, 1910.7707075150931, 1954.4039068084228, 1968.8228059474573, 1982.2467462364355, 1984.7022946558131, 131150.0, 133059.0, 135035.0, 136210.0, 158268.0, 12094.879051209551, 12135.27188368683, 12188.390580470941, 12283.815742763865, 12290.754184916252, 15930.283137258852, 16130.193490325437, 16156.676866462605, 16162.515124546282, 16179.271932763055, 9042.367034307666, 9162.725118246462, 9208.539573021457, 9225.446473211628, 9296.535173241446, 7770.611469426506, 8538.957305213435, 9001.864972025294, 9151.313651476166, 9176.403533770417, 4887.095887260868, 4892.804287828518, 4903.534164254462, 4964.255361695775, 5021.271915572222, 2098.7061811346425, 2133.861299015559, 2138.9358319250446, 2140.582586395638, 2157.967630485544, 1031.515187861704, 1045.4720366215165, 1055.1084333737979, 1059.7191744187796, 1072.8873468285874, 21692.132314707236, 21985.23051693183, 22003.22988695388, 22009.0, 22069.889650551966, 1069.641670040545, 1081.983770243447, 1101.5758932810925, 1108.9778204435866, 1125.6735546691532, 11039.83440248397, 11095.0, 11162.162837787198, 11261.32432054063, 11278.0, 742339.0, 749615.0, 752565.0, 753538.0, 766889.3244270167, 153763.0, 162305.0, 163157.55263671055, 163319.0, 169282.0, 1029.5109822834243, 1032.396048311746, 1065.3235195650818, 1104.8895110488886, 1108.5011744714911, 14944.028638138487, 19491.805081948998, 19931.701024484933, 20198.697019545012, 20368.59262814765, 43488.78255608702, 49979.0, 56314.43685563092, 60021.39978600333, 60299.095513566455, 90119.54940225257, 90222.0, 90551.54724226336, 90974.0, 91493.08506915112, 8546.273566746648, 8561.957190214009, 8614.526201059001, 8890.0, 8895.822083558163, 12830.037747168813, 12911.096223264656, 13313.068085233941, 13569.1858488491, 13726.519571814939, 11444.484998174936, 11709.707257318636, 11813.0, 11816.881831181578, 12005.699857503632, 9254.305927055633, 10445.477726113815, 10686.0916822071, 10819.67540973772, 10864.674059778219, 11700.941495292469, 11769.764604707687, 11835.46740396667, 11836.70408239801, 11862.0, 8639.179277968582, 8866.512341821004, 8920.800043969379, 8995.235404990388, 9064.274858011211, 10865.511052002837, 11647.355263680254, 11913.940430297793, 11978.221415607957, 11996.40017999114], "value": 10397.178231409334, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1297.902657300702, 1463.2098666719971, 1465.8419848319827, 1478.0835881753314, 1487.3753023730035, 7708.653110610022, 7965.641546130423, 8238.011438627365, 8694.0, 8713.564321783917, 8181.100078991321, 8327.0, 8495.745127646165, 8499.0, 8596.226339629433, 2377.2036367816804, 2401.111588712179, 2407.9157229496973, 2413.1795189635523, 2414.5291668124723, 2147.7100591420194, 2226.92205772798, 2379.428937055103, 2421.5278020785954, 2429.1740808125232, 2320.373499155227, 2374.9168779092734, 2398.2805158452484, 2407.8675672837985, 2415.915442959497, 2128.6913397557346, 2377.714674239085, 2396.101461951768, 2397.568437681217, 2408.8554686718853, 2393.772591603795, 2408.337707130536, 2424.0303878448585, 2424.9272521824196, 2426.1993542131054, 8419.747407577783, 8492.447990880573, 8492.957535212347, 8509.149085091503, 8612.440191387539, 5221.39953905302, 5264.710440925747, 5348.759305831247, 5365.678059316453, 5376.247325374451, 3439.243366459375, 3659.414493681025, 3703.9444408333898, 3705.314516814371, 3723.3670276053135, 1213.4963989944163, 1256.133268045046, 1273.8216649669055, 1282.160185078775, 1304.452130105358, 10520.631777887736, 10819.0, 10831.187660925383, 11130.0, 11134.27627204229, 4419.469663640384, 4456.398386217884, 4643.117807616542, 4647.651426143053, 4668.183067963093, 8721.60752766127, 8728.214460698568, 8731.912680873236, 8739.43193692408, 8750.256228220545, 5201.427842937273, 5220.216967454836, 5220.3735551734035, 5238.842834714965, 5244.239585260192, 4706.364640773451, 4829.058333624979, 4904.0191961607825, 4917.827876024322, 4918.754062296943, 3060.5409188621884, 3739.1773809761808, 3747.194353214072, 3806.7715937043868, 3845.057960799566, 1115.5664970512853, 1145.410113791398, 1183.1836033137108, 1195.3784032303327, 1295.9092863499652, 803.236924921327, 829.6349606173385, 875.0680525240598, 926.3654396738256, 969.520087556664, 4545.795439205178, 5231.267622532849, 5659.405762394971, 5827.271591051119, 5966.788350130932, 863.4215075899162, 958.0323872888293, 988.8961659025842, 1016.2936758952457, 1058.7088550648634, 3766.5856755756845, 3900.8829735107993, 3986.940195897064, 3990.7605543667473, 4018.959810401917, 9808.117269445784, 9874.456904870158, 10113.29206955506, 10114.595416183418, 10155.339902906288, 9945.30382873192, 10065.69802905914, 10098.394096354243, 10124.139448146843, 10158.847617285746, 7781.922180778233, 7905.0, 7984.9201507985335, 8013.078495972921, 8085.0, 5613.46672066153, 5719.982738865751, 5733.426657334233, 5859.974504461788, 5869.295684517885, 8976.86534701967, 9216.631334746535, 9263.212626926517, 9279.257659387098, 9369.297302702462, 9090.863637045582, 9328.626854925727, 9368.250539956924, 9374.390664606779, 9579.568919398504, 7235.963820180866, 7303.30618591233, 7353.154387245321, 7387.261273872569, 7388.335049845325, 7826.530408175528, 7850.450468467381, 7937.8412431752195, 7940.841183176189, 7945.1260361361365, 5579.6652200868075, 6929.85657366549, 6942.166939967236, 6956.930430695628, 7029.507934444539, 6855.143107111611, 6882.931170688429, 6896.586204827727, 6957.2694867038235, 6974.37230649244, 6442.194725659293, 6452.451541618827, 6548.410643042149, 6555.016747487915, 6557.180352455943, 4314.956850431456, 4963.776630051584, 4985.1276026695905, 5086.313347698014, 5201.985612805466, 5111.239930437522, 5131.461196574306, 5150.201718733602, 5214.582833373397, 5222.817201397933], "value": 4463.031108735199, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.2569158915812, 374.11708368250925, 379.66399736233427, 380.5129434324064, 382.0620376974528, 4499.730016199031, 5292.147748288097, 5403.0274550580925, 5434.619576629638, 5508.584677499945, 4304.870853874389, 4491.6406687465005, 5179.989901969108, 5281.366236051679, 5434.375046869611, 3407.0800883761494, 3483.9651603483894, 4218.852340168087, 4324.567543245666, 4355.237833379162, 4208.915821683565, 4261.850835220768, 4272.893177670552, 4336.956630433687, 4349.173657005159, 3904.4728961590104, 3948.453247655261, 4091.37912947041, 4273.38035984782, 4274.499417840567, 3861.7876016819064, 3888.3389823730035, 4086.6117718816663, 4339.457567804025, 4360.607545320905, 3403.6596340365763, 3560.768550044265, 3590.4973303737497, 3596.226811235571, 3857.556381016191, 4666.39336886206, 4940.5059494050665, 5402.78388864445, 5411.891762164774, 5415.83752487426, 4293.677974151919, 4805.318138651479, 4859.319695242669, 4865.8783530411665, 4868.561829435333, 5106.948930510722, 5626.930883132191, 5697.800576979786, 5815.331236907768, 5879.294484661825, 3992.9201415971806, 3995.0, 4001.299772539794, 4016.297147999118, 4026.8858849104163, 4380.9780951095045, 5834.883302333929, 6124.805662895737, 6164.599301045418, 6203.883301005817, 3847.249786291702, 4011.956891208307, 4040.6565441937764, 4060.167665628598, 4068.7558746474715, 3320.020593924798, 3399.2663741491524, 4016.819243134066, 4061.3907913813164, 4087.509498860156, 4570.4743954445, 4815.590674792612, 4830.396200474941, 4849.684770489906, 4858.441279252931, 5332.9733351333, 5459.645123067067, 5739.942600574024, 5893.410658934158, 6000.33996260411, 1226.675450022203, 1264.8102784582202, 1275.6159566869865, 1327.4491086199312, 1338.8460327062319, 787.9684812607546, 856.9528675922884, 904.3759805734022, 906.3746015249457, 906.8458362078462, 4592.586667199968, 4592.6555508337005, 5228.92156617651, 5252.527272545489, 5271.05121078202, 4976.353074100344, 5215.947840521622, 5499.9825032368335, 5845.415458454206, 5860.648361098262, 4724.87380678696, 4903.523720521114, 4964.429090654548, 5060.0, 5229.666435059035, 2594.6626938497875, 2857.3713782967716, 3008.533677280025, 3046.5277881928337, 3070.217094640897, 4721.409823772028, 5007.8966833929835, 5122.410922743932, 5126.333576635014, 5671.432856714296, 4963.6525443218625, 5201.373306480279, 5229.908036785317, 5719.370869204467, 6240.00159974411, 6303.180586523723, 6305.18032655761, 6317.0, 6339.657334725727, 6340.619562826245, 4869.490457958044, 4959.851204463872, 5770.5095066919785, 6079.392060793885, 6128.754849805958, 4793.952060479351, 5904.3210030847, 6001.639901605918, 6022.698865056817, 6046.667433291035, 4839.0, 5575.916361254665, 6318.704665543461, 6346.650934198663, 6347.666989932166, 3797.2785170817456, 3856.749311294757, 3995.940060899031, 4013.2174226025645, 4030.7783071931326, 5875.41245875409, 5974.372690867396, 6041.426064524039, 6087.421694938974, 6106.687062281453, 5672.461116193955, 5734.598578099493, 5890.9396308664855, 5905.232319798399, 5940.376260492759, 4665.930011049905, 5516.310461192351, 5747.942520574741, 5821.738021788945, 5836.708164591669, 4737.360456338351, 5711.457411545896, 5737.397573254915, 5771.653700777799, 5789.710514474344, 5448.727563621724, 5809.796657116981, 5833.433289352672, 5841.415858414124, 5863.77807978255, 5733.770649173986, 5739.684317362585, 5762.971185144047, 5767.5674324425, 5794.246747922743], "value": 4199.613714994963, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.4030914804438, 732.6702983657356, 779.6647441600112, 802.8273921106961, 859.0328148539842, 15148.697026059472, 15773.369065237406, 16296.59258518536, 16425.342986280564, 16636.58408539787, 14191.574252772407, 14299.213543255117, 14408.855911440909, 14425.206613636272, 15048.774268385983, 878.7275944457207, 885.7829831691245, 895.1764376773384, 895.5656506594297, 896.820635872828, 714.4106112457217, 737.8524295140967, 860.9096044915257, 894.472261365794, 897.851854444016, 895.7536677413731, 911.1253196930954, 941.6751220828803, 944.631593678466, 945.5792172483248, 935.1163150822475, 937.315759495572, 938.7230766923774, 939.1219210038636, 939.7556635274843, 671.5668393885965, 699.0527834783896, 699.1889408286363, 700.6251655364356, 701.2216439751871, 15547.844521554753, 15578.221088945507, 15898.443554475654, 16106.677866442606, 16334.591635209095, 13517.053806233567, 14632.707345853023, 14971.07994612154, 14998.625034374229, 15108.471203507825, 9314.86027709585, 10131.341462804894, 11192.38441885696, 11753.647390578297, 12008.279503229835, 3826.9043273918096, 3844.557875844258, 3861.710371722132, 3889.202713443737, 3937.232239713257, 97329.0, 97551.02448975561, 98911.0, 102151.99999999926, 103315.0, 10923.289986150874, 11121.833172502418, 11433.942830285796, 11511.19421640494, 11724.472398742077, 23010.65484017741, 23017.769822301896, 23156.7684323158, 23175.0, 23284.767152328597, 8051.146823225059, 8056.436049476481, 8247.917520824834, 8311.16888311164, 8403.0, 4483.103379324149, 4510.21071312519, 4523.95476045242, 4525.637948964075, 4546.158960592301, 3674.9632503675157, 3766.4915236443276, 3775.5846856845724, 3785.1294202333615, 3789.2610940866816, 680.2313385873931, 685.766839274649, 686.8111269400855, 709.8757717399434, 712.1240873725346, 609.5032548472981, 704.3660705365212, 712.5984641081692, 725.5501589014845, 728.3153835394712, 10211.655234594053, 10470.319429237075, 10600.0, 10712.303700259457, 10825.945870270756, 566.7676252736359, 576.20771439271, 580.1327016110941, 595.6158277910723, 595.8659301657093, 4713.34013238147, 4798.856034318976, 4988.301637770715, 5080.669756465818, 5171.741412929338, 102064.0, 104397.0, 104895.0, 105864.9413505855, 106179.0, 72790.908136378, 89814.0, 91102.08897910937, 93817.53091234637, 94915.52542237245, 71419.64290178516, 78687.0, 80157.19842801614, 82299.7655035175, 83349.58325208335, 9926.702198934043, 9951.402915825074, 9955.950220248853, 9995.100440960348, 10011.099001089937, 52880.67798305073, 53331.93336133178, 53876.0, 53929.19106213489, 54806.72596637151, 68514.65742671255, 69389.0, 69920.0, 72177.27822721915, 72255.63872180606, 12134.939325303318, 12162.0, 12245.816312755138, 12622.116451848282, 12694.682632934251, 13088.411021504246, 13176.209427434385, 13274.336283185996, 13495.865041349462, 13992.0, 12289.324087175291, 12328.383580820744, 12684.619461416172, 12691.42888570035, 13113.0, 12008.519659213884, 12208.877911220774, 12269.57056503018, 12303.507859685513, 12604.49582016709, 11703.707407314885, 12194.0, 12222.572209972608, 12377.752444950871, 12638.568790351126, 8810.0, 8915.242204412698, 9308.813823723352, 9317.44095354281, 9623.711288661352, 7891.565963872042, 9001.02149097999, 10286.897131028893, 10312.0, 10413.375197488174], "value": 7506.577939592852, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1514.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 176.0, 126.0, 118.0, 118.0, 118.0, 120.0, 118.0, 119.0, 118.0], "value": 124.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 123.0, 114.0, 145.0, 111.0, 111.0, 110.0, 110.0, 141.0, 141.0], "value": 124.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 191.0, 195.0, 195.0, 193.0, 198.0, 198.0, 225.0, 263.0, 192.0], "value": 205.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 59.0, 86.0, 61.0, 59.0, 60.0, 52.0, 87.0, 84.0], "value": 68.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 101.0, 102.0, 70.0, 71.0, 69.0, 86.0, 59.0, 89.0, 112.0], "value": 85.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 90.0, 88.0, 91.0, 85.0, 90.0, 94.0, 89.0, 88.0], "value": 89.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 115.0, 128.0, 101.0, 99.0, 98.0, 99.0, 148.0, 98.0, 99.0], "value": 108.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 96.0, 101.0, 92.0, 95.0, 93.0, 92.0, 93.0, 92.0, 93.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 59.0, 60.0, 62.0, 61.0, 62.0, 62.0, 62.0], "value": 60.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 71.0, 85.0, 75.0, 75.0, 68.0, 71.0, 71.0, 70.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 75.0, 88.0, 72.0, 73.0, 72.0, 92.0, 103.0, 102.0, 105.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 157.0, 135.0, 133.0, 139.0, 153.0, 159.0, 148.0, 178.0, 135.0], "value": 147.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 190.0, 164.0, 221.0, 225.0, 173.0, 155.0, 144.0, 146.0, 204.0], "value": 179.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 65.0, 66.0, 81.0, 57.0, 60.0, 67.0, 85.0, 89.0], "value": 70.1, "unit": "score"}]}]} 16:54:27 INFO - Return code: 0 16:54:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:54:27 ERROR - # TBPL SUCCESS # 16:54:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:54:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:54:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:54:27 INFO - 2017-03-28 16:54:27.242 screenresolution[1659:10548] starting screenresolution argv=screenresolution get 16:54:27 INFO - 2017-03-28 16:54:27.244 screenresolution[1659:10548] Display 0: 1600x1200x32@60 16:54:27 INFO - 2017-03-28 16:54:27.251 screenresolution[1660:10551] starting screenresolution argv=screenresolution list 16:54:27 INFO - Available Modes on Display 0 16:54:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:54:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:54:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:54:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:54:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:54:27 INFO - Intel Iris: 16:54:27 INFO - Chipset Model: Intel Iris 16:54:27 INFO - Type: GPU 16:54:27 INFO - Bus: Built-In 16:54:27 INFO - VRAM (Dynamic, Max): 1536 MB 16:54:27 INFO - Vendor: Intel (0x8086) 16:54:27 INFO - Device ID: 0x0a2e 16:54:27 INFO - Revision ID: 0x0009 16:54:27 INFO - Displays: 16:54:27 INFO - Display: 16:54:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:54:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:54:27 INFO - Display Serial Number: 1600x1200 60 16:54:27 INFO - Main Display: Yes 16:54:27 INFO - Mirror: Off 16:54:27 INFO - Online: Yes 16:54:27 INFO - Rotation: Supported 16:54:27 INFO - Return code: 0 16:54:27 INFO - Running post-action listener: _resource_record_post_action 16:54:27 INFO - [mozharness: 2017-03-28 23:54:27.494724Z] Finished run-tests step (success) 16:54:27 INFO - Running post-run listener: _resource_record_post_run 16:54:27 INFO - Total resource usage - Wall time: 1190s; CPU: 54.0%; Read bytes: 40810496; Write bytes: 422778368; Read time: 392; Write time: 1458 16:54:27 INFO - TinderboxPrint: CPU usage
54.3% 16:54:27 INFO - TinderboxPrint: I/O read bytes / time
40,810,496 / 392 16:54:27 INFO - TinderboxPrint: I/O write bytes / time
422,778,368 / 1,458 16:54:27 INFO - TinderboxPrint: CPU idle
2,177.2 (45.7%) 16:54:27 INFO - TinderboxPrint: CPU system
958.4 (20.1%) 16:54:27 INFO - TinderboxPrint: CPU user
1,626.0 (34.1%) 16:54:27 INFO - TinderboxPrint: Swap in / out
162,902,016 / 0 16:54:27 INFO - install - Wall time: 15s; CPU: 53.0%; Read bytes: 113349120; Write bytes: 112734208; Read time: 10086; Write time: 213 16:54:27 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 39884800; Write bytes: 300201472; Read time: 378; Write time: 1212 16:54:27 INFO - Running post-run listener: _upload_blobber_files 16:54:27 INFO - Blob upload gear active. 16:54:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:54:27 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:54:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:54:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:54:28 INFO - (blobuploader) - INFO - Open directory for files ... 16:54:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:54:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:54:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:54:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:54:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:54:29 INFO - (blobuploader) - INFO - Done attempting. 16:54:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:54:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:54:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:54:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:54:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:54:30 INFO - (blobuploader) - INFO - Done attempting. 16:54:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:54:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:54:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:54:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:54:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:54:31 INFO - (blobuploader) - INFO - Done attempting. 16:54:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:54:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:54:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:54:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:54:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:54:33 INFO - (blobuploader) - INFO - Done attempting. 16:54:33 INFO - (blobuploader) - INFO - Iteration through files over. 16:54:33 INFO - Return code: 0 16:54:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:54:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:54:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/100bb46edcd749f340bb2c4ebde23072abc768a5ff5eb1f6165e2612391cd032af87fba8b313a9d617db4add97693e78d13a1474a09f4140dfe3a4b5d12d6ebc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/642a6e7b8380c1f82f1659b4d66a5c695cad5e9b78855d208ce1eeb2baaa380262a1e0809819e8353f8f3d791b4d9cb45ca47eb3b15f026e8ac876f72be97107", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/47da416e3cf40201ab8a9877af1f2f67290dee336e845b0248dde7a658f1c401cfc1b947845dbdde60016872d0d72339d0d6a44ff6bcaa96e5cb1c0652544310", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/077dc163dbbb9004dc78e6647ad988c838fac8add729eab7c59e21e99d58c5136a0cdc45a9a167634fd5a84d0f9489e9955f2b3247f6aaa49a622652e7f90759"} 16:54:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:54:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:54:33 INFO - Contents: 16:54:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/100bb46edcd749f340bb2c4ebde23072abc768a5ff5eb1f6165e2612391cd032af87fba8b313a9d617db4add97693e78d13a1474a09f4140dfe3a4b5d12d6ebc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/642a6e7b8380c1f82f1659b4d66a5c695cad5e9b78855d208ce1eeb2baaa380262a1e0809819e8353f8f3d791b4d9cb45ca47eb3b15f026e8ac876f72be97107", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/47da416e3cf40201ab8a9877af1f2f67290dee336e845b0248dde7a658f1c401cfc1b947845dbdde60016872d0d72339d0d6a44ff6bcaa96e5cb1c0652544310", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/077dc163dbbb9004dc78e6647ad988c838fac8add729eab7c59e21e99d58c5136a0cdc45a9a167634fd5a84d0f9489e9955f2b3247f6aaa49a622652e7f90759"} 16:54:33 INFO - Running post-run listener: copy_logs_to_upload_dir 16:54:33 INFO - Copying logs to upload dir... 16:54:33 INFO - mkdir: /builds/slave/test/build/upload/logs 16:54:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.396689 ========= master_lag: 0.24 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-03-28 16:54:34.028003) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-28 16:54:34.031389) ========= 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.DbSeDRTmUE/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.yKlV9jC6jI/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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/100bb46edcd749f340bb2c4ebde23072abc768a5ff5eb1f6165e2612391cd032af87fba8b313a9d617db4add97693e78d13a1474a09f4140dfe3a4b5d12d6ebc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/642a6e7b8380c1f82f1659b4d66a5c695cad5e9b78855d208ce1eeb2baaa380262a1e0809819e8353f8f3d791b4d9cb45ca47eb3b15f026e8ac876f72be97107", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/47da416e3cf40201ab8a9877af1f2f67290dee336e845b0248dde7a658f1c401cfc1b947845dbdde60016872d0d72339d0d6a44ff6bcaa96e5cb1c0652544310", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/077dc163dbbb9004dc78e6647ad988c838fac8add729eab7c59e21e99d58c5136a0cdc45a9a167634fd5a84d0f9489e9955f2b3247f6aaa49a622652e7f90759"} build_url:https://queue.taskcluster.net/v1/task/EfFEyO-RThqYztfVPt0FEA/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010517 build_url: 'https://queue.taskcluster.net/v1/task/EfFEyO-RThqYztfVPt0FEA/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/100bb46edcd749f340bb2c4ebde23072abc768a5ff5eb1f6165e2612391cd032af87fba8b313a9d617db4add97693e78d13a1474a09f4140dfe3a4b5d12d6ebc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/642a6e7b8380c1f82f1659b4d66a5c695cad5e9b78855d208ce1eeb2baaa380262a1e0809819e8353f8f3d791b4d9cb45ca47eb3b15f026e8ac876f72be97107", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/47da416e3cf40201ab8a9877af1f2f67290dee336e845b0248dde7a658f1c401cfc1b947845dbdde60016872d0d72339d0d6a44ff6bcaa96e5cb1c0652544310", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/077dc163dbbb9004dc78e6647ad988c838fac8add729eab7c59e21e99d58c5136a0cdc45a9a167634fd5a84d0f9489e9955f2b3247f6aaa49a622652e7f90759"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-28 16:54:34.064947) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 16:54:34.065259) ========= 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.DbSeDRTmUE/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.yKlV9jC6jI/Listeners TMPDIR=/var/folders/yg/ccdgyw0j4yvb_ynprnv7y9t800000w/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.005229 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 16:54:34.113490) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-28 16:54:34.113791) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-28 16:54:34.114096) ========= ========= Total master_lag: 2.71 =========