builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0083 starttime: 1485372317.98 results: success (0) buildid: 20170125090232 builduid: e49c8819c332425886cde4b3dfc461e5 revision: e8e90b0da7c42819565ecbde023b531a8ad95065 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-25 11:25:17.983308) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-25 11:25:17.983774) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-25 11:25:17.984045) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-25 11:25:18.010164) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 11:25:18.010568) ========= 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.1ByErFIvFU/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.l7B6taokfG/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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-01-25 11:25:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.81M=0.001s 2017-01-25 11:25:18 (8.81 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093051 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 11:25:18.128243) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 11:25:18.128597) ========= 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.1ByErFIvFU/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.l7B6taokfG/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.026002 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 11:25:18.177280) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-25 11:25:18.177646) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e8e90b0da7c42819565ecbde023b531a8ad95065 --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 e8e90b0da7c42819565ecbde023b531a8ad95065 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1ByErFIvFU/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.l7B6taokfG/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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-01-25 11:25:18,320 truncating revision to first 12 chars 2017-01-25 11:25:18,320 Setting DEBUG logging. 2017-01-25 11:25:18,320 attempt 1/10 2017-01-25 11:25:18,320 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e8e90b0da7c4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-25 11:25:19,297 unpacking tar archive at: mozilla-beta-e8e90b0da7c4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.249272 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-25 11:25:19.451281) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-25 11:25:19.451700) ========= script_repo_revision: e8e90b0da7c42819565ecbde023b531a8ad95065 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-25 11:25:19.452120) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-25 11:25:19.452433) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-25 11:25:19.472820) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-25 11:25:19.473225) ========= /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.1ByErFIvFU/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.l7B6taokfG/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 11:25:19 INFO - MultiFileLogger online at 20170125 11:25:19 in /builds/slave/test 11:25:19 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 11:25:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:25:19 INFO - {'append_to_log': False, 11:25:19 INFO - 'base_work_dir': '/builds/slave/test', 11:25:19 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:25:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:25:19 INFO - 'branch': 'Mozilla-Beta', 11:25:19 INFO - 'buildbot_json_path': 'buildprops.json', 11:25:19 INFO - 'config_files': ('talos/mac_config.py',), 11:25:19 INFO - 'default_actions': ('clobber', 11:25:19 INFO - 'read-buildbot-config', 11:25:19 INFO - 'download-and-extract', 11:25:19 INFO - 'populate-webroot', 11:25:19 INFO - 'create-virtualenv', 11:25:19 INFO - 'install', 11:25:19 INFO - 'run-tests'), 11:25:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:25:19 INFO - 'download_minidump_stackwalk': True, 11:25:19 INFO - 'download_symbols': 'ondemand', 11:25:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:25:19 INFO - 'tooltool.py': '/tools/tooltool.py', 11:25:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:25:19 INFO - '/tools/misc-python/virtualenv.py')}, 11:25:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:25:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:25:19 INFO - 'installer_path': 'installer.exe', 11:25:19 INFO - 'log_level': 'info', 11:25:19 INFO - 'log_name': 'talos', 11:25:19 INFO - 'log_to_console': True, 11:25:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:25:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:25:19 INFO - 'opt_config_files': (), 11:25:19 INFO - 'pip_index': False, 11:25:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:25:19 INFO - 'cmd': ('bash', 11:25:19 INFO - '-c', 11:25:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:25:19 INFO - 'enabled': True, 11:25:19 INFO - 'halt_on_failure': False, 11:25:19 INFO - 'name': 'check_screen_resolution'},), 11:25:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:25:19 INFO - 'cmd': ('bash', 11:25:19 INFO - '-c', 11:25:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:25:19 INFO - 'enabled': True, 11:25:19 INFO - 'halt_on_failure': False, 11:25:19 INFO - 'name': 'check_screen_resolution'},), 11:25:19 INFO - 'run_cmd_checks_enabled': True, 11:25:19 INFO - 'sps_profile': False, 11:25:19 INFO - 'sps_profile_interval': 0, 11:25:19 INFO - 'suite': 'dromaeojs-e10s', 11:25:19 INFO - 'system_bits': '32', 11:25:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:25:19 INFO - 'title': 't-yosemite-r7-0083', 11:25:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:25:19 INFO - 'use_talos_json': True, 11:25:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:25:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:25:19 INFO - 'work_dir': 'build'} 11:25:19 INFO - [mozharness: 2017-01-25 19:25:19.725218Z] Running clobber step. 11:25:19 INFO - Running pre-action listener: _resource_record_pre_action 11:25:19 INFO - Running main action method: clobber 11:25:19 INFO - rmtree: /builds/slave/test/build 11:25:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:25:22 INFO - Running post-action listener: _resource_record_post_action 11:25:22 INFO - [mozharness: 2017-01-25 19:25:22.392850Z] Finished clobber step (success) 11:25:22 INFO - [mozharness: 2017-01-25 19:25:22.393001Z] Running read-buildbot-config step. 11:25:22 INFO - Running pre-action listener: _resource_record_pre_action 11:25:22 INFO - Running main action method: read_buildbot_config 11:25:22 INFO - Using buildbot properties: 11:25:22 INFO - { 11:25:22 INFO - "project": "", 11:25:22 INFO - "product": "firefox", 11:25:22 INFO - "script_repo_revision": "production", 11:25:22 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 11:25:22 INFO - "repository": "", 11:25:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 11:25:22 INFO - "buildid": "20170125090232", 11:25:22 INFO - "pgo_build": "False", 11:25:22 INFO - "basedir": "/builds/slave/test", 11:25:22 INFO - "buildnumber": 52, 11:25:22 INFO - "slavename": "t-yosemite-r7-0083", 11:25:22 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 11:25:22 INFO - "platform": "yosemite_r7", 11:25:22 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:25:22 INFO - "branch": "mozilla-beta", 11:25:22 INFO - "repo_path": "releases/mozilla-beta", 11:25:22 INFO - "revision": "e8e90b0da7c42819565ecbde023b531a8ad95065", 11:25:22 INFO - "stage_platform": "macosx64", 11:25:22 INFO - "builduid": "e49c8819c332425886cde4b3dfc461e5", 11:25:22 INFO - "slavebuilddir": "test" 11:25:22 INFO - } 11:25:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/V3XuJdNRThePMmWT_sJM5g/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 11:25:22 INFO - Running post-action listener: _resource_record_post_action 11:25:22 INFO - [mozharness: 2017-01-25 19:25:22.396237Z] Finished read-buildbot-config step (success) 11:25:22 INFO - [mozharness: 2017-01-25 19:25:22.396341Z] Running download-and-extract step. 11:25:22 INFO - Running pre-action listener: _resource_record_pre_action 11:25:22 INFO - Running main action method: download_and_extract 11:25:22 INFO - mkdir: /builds/slave/test/build/tests 11:25:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:22 INFO - trying https://queue.taskcluster.net/v1/task/V3XuJdNRThePMmWT_sJM5g/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 11:25:22 INFO - Downloading https://queue.taskcluster.net/v1/task/V3XuJdNRThePMmWT_sJM5g/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 11:25:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V3XuJdNRThePMmWT_sJM5g/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 11:25:23 INFO - Downloaded 1165 bytes. 11:25:23 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 11:25:23 INFO - Using the following test package requirements: 11:25:23 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 11:25:23 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:25:23 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 11:25:23 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:25:23 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 11:25:23 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:25:23 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:25:23 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 11:25:23 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 11:25:23 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:25:23 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 11:25:23 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:25:23 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 11:25:23 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:25:23 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 11:25:23 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:25:23 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 11:25:23 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 11:25:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V3XuJdNRThePMmWT_sJM5g/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 11:25:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V3XuJdNRThePMmWT_sJM5g/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 11:25:23 INFO - Fetch https://queue.taskcluster.net/v1/task/V3XuJdNRThePMmWT_sJM5g/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 11:25:24 INFO - Http code: 200 11:25:24 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 11:25:24 INFO - x-amz-cf-id: oyjj8kTIdh29a9MLQOi2Lx_cSytEKMORZ7TBR7V_lPKtJY1FKSax-A== 11:25:24 INFO - x-amz-version-id: iBdu53Qp1vY1wjuny6uWtbM7Cp9PU12v 11:25:24 INFO - Expected file size: 16086204 11:25:24 INFO - Obtained file size: 16086204 11:25:31 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 11:25:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V3XuJdNRThePMmWT_sJM5g/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 11:25:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V3XuJdNRThePMmWT_sJM5g/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 11:25:31 INFO - Fetch https://queue.taskcluster.net/v1/task/V3XuJdNRThePMmWT_sJM5g/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 11:25:31 INFO - Http code: 200 11:25:31 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 11:25:31 INFO - x-amz-cf-id: Cqy1G5WCmeQ89vI7XP_H036IbbS9MnX027RrqzgFZ_YlVfMkxaghcA== 11:25:31 INFO - x-amz-version-id: iBdu53Qp1vY1wjuny6uWtbM7Cp9PU12v 11:25:32 INFO - Expected file size: 16086204 11:25:32 INFO - Obtained file size: 16086204 11:25:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V3XuJdNRThePMmWT_sJM5g/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 11:25:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V3XuJdNRThePMmWT_sJM5g/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 11:25:38 INFO - Fetch https://queue.taskcluster.net/v1/task/V3XuJdNRThePMmWT_sJM5g/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 11:25:40 INFO - Http code: 200 11:25:40 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 11:25:40 INFO - x-amz-cf-id: xxCuAa5TKFbucgI6E81-n0dO3xb0SoGRz14uJJAxU4tOVVf7kLdw7A== 11:25:40 INFO - x-amz-version-id: c5f540T5wNZ8GheFoTWX4oZ7rOXw.UnU 11:25:40 INFO - Expected file size: 14402992 11:25:40 INFO - Obtained file size: 14402992 11:25:41 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')]} 11:25:41 INFO - trying https://queue.taskcluster.net/v1/task/V3XuJdNRThePMmWT_sJM5g/artifacts/public/build/firefox-52.0.en-US.mac.dmg 11:25:41 INFO - Downloading https://queue.taskcluster.net/v1/task/V3XuJdNRThePMmWT_sJM5g/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 11:25:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V3XuJdNRThePMmWT_sJM5g/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 11:25:43 INFO - Downloaded 82125682 bytes. 11:25:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V3XuJdNRThePMmWT_sJM5g/artifacts/public/build/firefox-52.0.en-US.mac.dmg 11:25:43 INFO - mkdir: /builds/slave/test/properties 11:25:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:25:43 INFO - Writing to file /builds/slave/test/properties/build_url 11:25:43 INFO - Contents: 11:25:43 INFO - build_url:https://queue.taskcluster.net/v1/task/V3XuJdNRThePMmWT_sJM5g/artifacts/public/build/firefox-52.0.en-US.mac.dmg 11:25:44 INFO - Running post-action listener: _resource_record_post_action 11:25:44 INFO - Running post-action listener: set_extra_try_arguments 11:25:44 INFO - [mozharness: 2017-01-25 19:25:44.479474Z] Finished download-and-extract step (success) 11:25:44 INFO - [mozharness: 2017-01-25 19:25:44.479640Z] Running populate-webroot step. 11:25:44 INFO - Running pre-action listener: _resource_record_pre_action 11:25:44 INFO - Running main action method: populate_webroot 11:25:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:25:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:25:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:25:44 INFO - '--tppagecycles', 11:25:44 INFO - '7'], 11:25:44 INFO - 'tests': ['tsvgm']}}, 11:25:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:25:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:25:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:25:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:25:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:25:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:25:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:44 INFO - 'talos_options': ['--disable-e10s'], 11:25:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:25:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:25:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:44 INFO - 'talos_options': ['--disable-e10s'], 11:25:44 INFO - 'tests': ['damp', 'tps']}, 11:25:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:44 INFO - 'tests': ['damp', 'tps']}, 11:25:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:25:44 INFO - 'tests': ['dromaeo_dom']}, 11:25:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:25:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:25:44 INFO - 'tests': ['basic_compositor_video']}, 11:25:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:25:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:25:44 INFO - 'tests': ['a11yr', 11:25:44 INFO - 'ts_paint', 11:25:44 INFO - 'tpaint', 11:25:44 INFO - 'sessionrestore', 11:25:44 INFO - 'sessionrestore_no_auto_restore', 11:25:44 INFO - 'tabpaint']}, 11:25:44 INFO - 'other-e10s': {'tests': ['a11yr', 11:25:44 INFO - 'ts_paint', 11:25:44 INFO - 'tpaint', 11:25:44 INFO - 'sessionrestore', 11:25:44 INFO - 'sessionrestore_no_auto_restore', 11:25:44 INFO - 'tabpaint']}, 11:25:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:25:44 INFO - 'ts_paint', 11:25:44 INFO - 'tpaint', 11:25:44 INFO - 'sessionrestore', 11:25:44 INFO - 'sessionrestore_no_auto_restore', 11:25:44 INFO - 'tabpaint']}, 11:25:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:25:44 INFO - 'ts_paint', 11:25:44 INFO - 'tpaint', 11:25:44 INFO - 'sessionrestore', 11:25:44 INFO - 'sessionrestore_no_auto_restore', 11:25:44 INFO - 'tabpaint']}, 11:25:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:25:44 INFO - 'tests': ['a11yr', 11:25:44 INFO - 'ts_paint', 11:25:44 INFO - 'tpaint', 11:25:44 INFO - 'sessionrestore', 11:25:44 INFO - 'sessionrestore_no_auto_restore', 11:25:44 INFO - 'tabpaint']}, 11:25:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:25:44 INFO - 'tests': ['a11yr', 11:25:44 INFO - 'ts_paint', 11:25:44 INFO - 'tpaint', 11:25:44 INFO - 'sessionrestore', 11:25:44 INFO - 'sessionrestore_no_auto_restore', 11:25:44 INFO - 'tabpaint']}, 11:25:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:25:44 INFO - 'tests': ['tsvgx', 11:25:44 INFO - 'tsvgr_opacity', 11:25:44 INFO - 'tart', 11:25:44 INFO - 'tscrollx', 11:25:44 INFO - 'cart']}, 11:25:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:25:44 INFO - 'tsvgr_opacity', 11:25:44 INFO - 'tart', 11:25:44 INFO - 'tscrollx', 11:25:44 INFO - 'cart']}, 11:25:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:44 INFO - 'talos_options': ['--disable-e10s'], 11:25:44 INFO - 'tests': ['tp5o']}, 11:25:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:44 INFO - 'tests': ['tp5o']}, 11:25:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:44 INFO - 'talos_options': ['--disable-e10s', 11:25:44 INFO - '--xperf_path', 11:25:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:25:44 INFO - 'tests': ['tp5n']}, 11:25:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:44 INFO - 'talos_options': ['--xperf_path', 11:25:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:25:44 INFO - 'tests': ['tp5n']}}, 11:25:44 INFO - 'talos.zip': {'path': '', 11:25:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:25:44 INFO - Running post-action listener: _resource_record_post_action 11:25:44 INFO - [mozharness: 2017-01-25 19:25:44.498821Z] Finished populate-webroot step (success) 11:25:44 INFO - [mozharness: 2017-01-25 19:25:44.498931Z] Running create-virtualenv step. 11:25:44 INFO - Running pre-action listener: _resource_record_pre_action 11:25:44 INFO - Running main action method: create_virtualenv 11:25:44 INFO - Creating virtualenv /builds/slave/test/build/venv 11:25:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:25:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:25:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:25:44 INFO - Using real prefix '/tools/python27' 11:25:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:25:45 INFO - Installing distribute.............................................................................................................................................................................................done. 11:25:48 INFO - Installing pip.................done. 11:25:48 INFO - Return code: 0 11:25:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:25:48 INFO - Reading from file tmpfile_stdout 11:25:48 INFO - Output received: 11:25:48 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) 11:25:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1042bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104235570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ee14a72a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040d3d30>, '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 0x103f39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040cbb20>, '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.1ByErFIvFU/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.l7B6taokfG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 11:25:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:25:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ByErFIvFU/Render', 11:25:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:25:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:25:48 INFO - 'HOME': '/Users/cltbld', 11:25:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:25:48 INFO - 'LOGNAME': 'cltbld', 11:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:48 INFO - 'MOZ_NO_REMOTE': '1', 11:25:48 INFO - 'NO_EM_RESTART': '1', 11:25:48 INFO - 'PAGER': '/bin/cat', 11:25:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:48 INFO - 'PWD': '/builds/slave/test', 11:25:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:25:48 INFO - 'SHELL': '/bin/bash', 11:25:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l7B6taokfG/Listeners', 11:25:48 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 11:25:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:25:48 INFO - 'USER': 'cltbld', 11:25:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:25:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:48 INFO - 'XPC_FLAGS': '0x0', 11:25:48 INFO - 'XPC_SERVICE_NAME': '0', 11:25:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:25:48 INFO - Cleaning up... 11:25:48 INFO - Return code: 0 11:25:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1042bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104235570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ee14a72a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040d3d30>, '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 0x103f39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040cbb20>, '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.1ByErFIvFU/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.l7B6taokfG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 11:25:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:25:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ByErFIvFU/Render', 11:25:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:25:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:25:48 INFO - 'HOME': '/Users/cltbld', 11:25:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:25:48 INFO - 'LOGNAME': 'cltbld', 11:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:48 INFO - 'MOZ_NO_REMOTE': '1', 11:25:48 INFO - 'NO_EM_RESTART': '1', 11:25:48 INFO - 'PAGER': '/bin/cat', 11:25:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:48 INFO - 'PWD': '/builds/slave/test', 11:25:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:25:48 INFO - 'SHELL': '/bin/bash', 11:25:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l7B6taokfG/Listeners', 11:25:48 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 11:25:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:25:48 INFO - 'USER': 'cltbld', 11:25:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:25:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:48 INFO - 'XPC_FLAGS': '0x0', 11:25:48 INFO - 'XPC_SERVICE_NAME': '0', 11:25:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:25:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:49 INFO - Downloading/unpacking psutil>=3.1.1 11:25:49 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 11:25:49 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 11:25:49 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 11:25:49 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 11:25:49 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 11:25:49 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 11:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:25:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:25:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:25:52 INFO - Installing collected packages: psutil 11:25:52 INFO - Running setup.py install for psutil 11:25:52 INFO - building 'psutil._psutil_osx' extension 11:25:52 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 11:25:53 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 11:25:53 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 11:25:53 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 11:25:53 INFO - building 'psutil._psutil_posix' extension 11:25:53 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 11:25:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:25:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:25:53 INFO - ^ 11:25:53 INFO - 1 warning generated. 11:25:53 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 11:25:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:25:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:25:53 INFO - Successfully installed psutil 11:25:53 INFO - Cleaning up... 11:25:53 INFO - Return code: 0 11:25:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:25:53 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')]} 11:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:53 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')]} 11:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:53 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 0x1042bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104235570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ee14a72a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040d3d30>, '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 0x103f39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040cbb20>, '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.1ByErFIvFU/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.l7B6taokfG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 11:25:53 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 11:25:53 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 11:25:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ByErFIvFU/Render', 11:25:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:25:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:25:53 INFO - 'HOME': '/Users/cltbld', 11:25:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:25:53 INFO - 'LOGNAME': 'cltbld', 11:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:53 INFO - 'MOZ_NO_REMOTE': '1', 11:25:53 INFO - 'NO_EM_RESTART': '1', 11:25:53 INFO - 'PAGER': '/bin/cat', 11:25:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:53 INFO - 'PWD': '/builds/slave/test', 11:25:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:25:53 INFO - 'SHELL': '/bin/bash', 11:25:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l7B6taokfG/Listeners', 11:25:53 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 11:25:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:25:53 INFO - 'USER': 'cltbld', 11:25:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:25:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:53 INFO - 'XPC_FLAGS': '0x0', 11:25:53 INFO - 'XPC_SERVICE_NAME': '0', 11:25:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:25:53 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 11:25:53 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 11:25:53 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 11:25:53 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 11:25:53 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 11:25:53 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 11:25:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:25:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:25:56 INFO - Installing collected packages: mozsystemmonitor 11:25:56 INFO - Running setup.py install for mozsystemmonitor 11:25:56 INFO - Successfully installed mozsystemmonitor 11:25:56 INFO - Cleaning up... 11:25:56 INFO - Return code: 0 11:25:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:56 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 0x1042bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104235570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ee14a72a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040d3d30>, '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 0x103f39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040cbb20>, '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.1ByErFIvFU/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.l7B6taokfG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 11:25:56 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 11:25:56 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 11:25:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ByErFIvFU/Render', 11:25:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:25:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:25:56 INFO - 'HOME': '/Users/cltbld', 11:25:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:25:56 INFO - 'LOGNAME': 'cltbld', 11:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:56 INFO - 'MOZ_NO_REMOTE': '1', 11:25:56 INFO - 'NO_EM_RESTART': '1', 11:25:56 INFO - 'PAGER': '/bin/cat', 11:25:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:56 INFO - 'PWD': '/builds/slave/test', 11:25:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:25:56 INFO - 'SHELL': '/bin/bash', 11:25:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l7B6taokfG/Listeners', 11:25:56 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 11:25:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:25:56 INFO - 'USER': 'cltbld', 11:25:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:25:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:56 INFO - 'XPC_FLAGS': '0x0', 11:25:56 INFO - 'XPC_SERVICE_NAME': '0', 11:25:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:57 INFO - Downloading/unpacking jsonschema==2.5.1 11:25:57 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 11:25:57 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 11:25:57 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 11:25:57 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 11:25:57 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 11:25:57 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 11:25:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:25:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:00 INFO - Downloading functools32-3.2.3-2.tar.gz 11:26:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:26:00 INFO - warning: no files found matching '*.txt' 11:26:00 INFO - no previously-included directories found matching 'build' 11:26:00 INFO - no previously-included directories found matching 'dist' 11:26:00 INFO - no previously-included directories found matching '.git*' 11:26:00 INFO - Installing collected packages: jsonschema, functools32 11:26:00 INFO - Running setup.py install for functools32 11:26:00 INFO - warning: no files found matching '*.txt' 11:26:00 INFO - no previously-included directories found matching 'build' 11:26:00 INFO - no previously-included directories found matching 'dist' 11:26:00 INFO - no previously-included directories found matching '.git*' 11:26:00 INFO - Successfully installed jsonschema functools32 11:26:00 INFO - Cleaning up... 11:26:00 INFO - Return code: 0 11:26:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:00 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 0x1042bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104235570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ee14a72a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040d3d30>, '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 0x103f39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040cbb20>, '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.1ByErFIvFU/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.l7B6taokfG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 11:26:00 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 11:26:00 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 11:26:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ByErFIvFU/Render', 11:26:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:26:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:26:00 INFO - 'HOME': '/Users/cltbld', 11:26:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:26:00 INFO - 'LOGNAME': 'cltbld', 11:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:00 INFO - 'MOZ_NO_REMOTE': '1', 11:26:00 INFO - 'NO_EM_RESTART': '1', 11:26:00 INFO - 'PAGER': '/bin/cat', 11:26:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:00 INFO - 'PWD': '/builds/slave/test', 11:26:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:26:00 INFO - 'SHELL': '/bin/bash', 11:26:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l7B6taokfG/Listeners', 11:26:00 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 11:26:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:26:00 INFO - 'USER': 'cltbld', 11:26:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:26:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:00 INFO - 'XPC_FLAGS': '0x0', 11:26:00 INFO - 'XPC_SERVICE_NAME': '0', 11:26:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:26:00 INFO - Cleaning up... 11:26:00 INFO - Return code: 0 11:26:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:00 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 0x1042bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104235570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ee14a72a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040d3d30>, '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 0x103f39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040cbb20>, '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.1ByErFIvFU/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.l7B6taokfG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 11:26:00 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 11:26:00 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 11:26:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ByErFIvFU/Render', 11:26:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:26:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:26:00 INFO - 'HOME': '/Users/cltbld', 11:26:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:26:00 INFO - 'LOGNAME': 'cltbld', 11:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:00 INFO - 'MOZ_NO_REMOTE': '1', 11:26:00 INFO - 'NO_EM_RESTART': '1', 11:26:00 INFO - 'PAGER': '/bin/cat', 11:26:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:00 INFO - 'PWD': '/builds/slave/test', 11:26:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:26:00 INFO - 'SHELL': '/bin/bash', 11:26:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l7B6taokfG/Listeners', 11:26:00 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 11:26:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:26:00 INFO - 'USER': 'cltbld', 11:26:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:26:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:00 INFO - 'XPC_FLAGS': '0x0', 11:26:00 INFO - 'XPC_SERVICE_NAME': '0', 11:26:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:00 INFO - Downloading/unpacking blobuploader==1.2.4 11:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:03 INFO - Downloading blobuploader-1.2.4.tar.gz 11:26:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:26:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:26:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:26:04 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 11:26:04 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 11:26:04 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 11:26:04 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 11:26:04 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 11:26:04 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 11:26:04 INFO - Downloading docopt-0.6.1.tar.gz 11:26:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:26:04 INFO - Installing collected packages: blobuploader, requests, docopt 11:26:04 INFO - Running setup.py install for blobuploader 11:26:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:26:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:26:05 INFO - Running setup.py install for requests 11:26:05 INFO - Running setup.py install for docopt 11:26:05 INFO - Successfully installed blobuploader requests docopt 11:26:05 INFO - Cleaning up... 11:26:05 INFO - Return code: 0 11:26:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:26:05 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')]} 11:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:05 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')]} 11:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:05 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 0x1042bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104235570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ee14a72a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040d3d30>, '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 0x103f39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040cbb20>, '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.1ByErFIvFU/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.l7B6taokfG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 11:26:05 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 11:26:05 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 11:26:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ByErFIvFU/Render', 11:26:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:26:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:26:05 INFO - 'HOME': '/Users/cltbld', 11:26:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:26:05 INFO - 'LOGNAME': 'cltbld', 11:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:05 INFO - 'MOZ_NO_REMOTE': '1', 11:26:05 INFO - 'NO_EM_RESTART': '1', 11:26:05 INFO - 'PAGER': '/bin/cat', 11:26:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:05 INFO - 'PWD': '/builds/slave/test', 11:26:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:26:05 INFO - 'SHELL': '/bin/bash', 11:26:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l7B6taokfG/Listeners', 11:26:05 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 11:26:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:26:05 INFO - 'USER': 'cltbld', 11:26:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:26:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:05 INFO - 'XPC_FLAGS': '0x0', 11:26:05 INFO - 'XPC_SERVICE_NAME': '0', 11:26:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:26:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:26:06 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-YrNKJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:26:06 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-U3XZES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:26:06 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-kIh1p9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:26:06 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Mjwume-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:26:06 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-7aqSkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:26:06 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-RetCjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:26:06 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-yoD9N4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:26:06 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-EAymeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:26:06 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-sok2a5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:26:07 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-RkDgVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:26:07 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-tIWdUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:26:07 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-WyEOYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:26:07 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-DlgyQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:26:07 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-m_n_Ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:26:07 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-NiuiV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:26:07 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-8B5mUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:26:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:26:07 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-XpsPMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:26:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:26:07 INFO - Running setup.py install for manifestparser 11:26:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:26:07 INFO - Running setup.py install for mozcrash 11:26:08 INFO - Running setup.py install for mozdebug 11:26:08 INFO - Running setup.py install for mozdevice 11:26:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:26:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:26:08 INFO - Running setup.py install for mozfile 11:26:08 INFO - Running setup.py install for mozhttpd 11:26:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:26:08 INFO - Running setup.py install for mozinfo 11:26:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:26:08 INFO - Running setup.py install for mozInstall 11:26:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:26:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:26:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:26:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:26:09 INFO - Running setup.py install for mozleak 11:26:09 INFO - Running setup.py install for mozlog 11:26:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:26:09 INFO - Running setup.py install for moznetwork 11:26:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:26:09 INFO - Running setup.py install for mozprocess 11:26:09 INFO - Running setup.py install for mozprofile 11:26:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:26:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:26:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:26:09 INFO - Running setup.py install for mozrunner 11:26:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:26:09 INFO - Running setup.py install for mozscreenshot 11:26:10 INFO - Running setup.py install for moztest 11:26:10 INFO - Running setup.py install for mozversion 11:26:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:26:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:26:10 INFO - Cleaning up... 11:26:10 INFO - Return code: 0 11:26:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:10 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 0x1042bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104235570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ee14a72a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040d3d30>, '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 0x103f39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040cbb20>, '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.1ByErFIvFU/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.l7B6taokfG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 11:26:10 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 11:26:10 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 11:26:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ByErFIvFU/Render', 11:26:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:26:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:26:10 INFO - 'HOME': '/Users/cltbld', 11:26:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:26:10 INFO - 'LOGNAME': 'cltbld', 11:26:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:10 INFO - 'MOZ_NO_REMOTE': '1', 11:26:10 INFO - 'NO_EM_RESTART': '1', 11:26:10 INFO - 'PAGER': '/bin/cat', 11:26:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:26:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:10 INFO - 'PWD': '/builds/slave/test', 11:26:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:26:10 INFO - 'SHELL': '/bin/bash', 11:26:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l7B6taokfG/Listeners', 11:26:10 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 11:26:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:26:10 INFO - 'USER': 'cltbld', 11:26:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:26:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:26:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:10 INFO - 'XPC_FLAGS': '0x0', 11:26:10 INFO - 'XPC_SERVICE_NAME': '0', 11:26:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:26:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:26:10 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-evaG0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:26:10 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)) 11:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:26:10 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-3A6W61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:26:10 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)) 11:26:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:26:10 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-wUgRFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:26:11 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)) 11:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:26:11 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-3fg_0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:26:11 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-y7wFGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:26:11 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)) 11:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:26:11 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-sShgTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:26:11 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)) 11:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:26:11 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-KKeFZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:26:11 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)) 11:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:26:11 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-DM8n9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:26:11 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)) 11:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:26:11 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-HeLgfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:26:11 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)) 11:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:26:11 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-WNGoxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:26:11 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)) 11:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:26:11 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-MWCc2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:26:11 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)) 11:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:26:11 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-h7SRHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:26:11 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-BRUmhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:26:12 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)) 11:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:26:12 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-xwh0Tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:26:12 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)) 11:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:26:12 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-RMGhEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:26:12 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)) 11:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:26:12 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-LFNIYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:26:12 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)) 11:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:26:12 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-EshXhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:26:12 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)) 11:26:12 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)) 11:26:12 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)) 11:26:12 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)) 11:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:26:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:26:12 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 11:26:12 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 11:26:12 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 11:26:12 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 11:26:12 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 11:26:12 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 11:26:15 INFO - Downloading blessings-1.6.tar.gz 11:26:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:26:15 INFO - Installing collected packages: blessings 11:26:15 INFO - Running setup.py install for blessings 11:26:15 INFO - Successfully installed blessings 11:26:15 INFO - Cleaning up... 11:26:15 INFO - Return code: 0 11:26:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:26:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:26:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:26:15 INFO - Reading from file tmpfile_stdout 11:26:15 INFO - Current package versions: 11:26:15 INFO - blessings == 1.6 11:26:15 INFO - blobuploader == 1.2.4 11:26:15 INFO - docopt == 0.6.1 11:26:15 INFO - functools32 == 3.2.3-2 11:26:15 INFO - jsonschema == 2.5.1 11:26:15 INFO - manifestparser == 1.1 11:26:15 INFO - mozInstall == 1.12 11:26:15 INFO - mozcrash == 1.0 11:26:15 INFO - mozdebug == 0.1 11:26:15 INFO - mozdevice == 0.48 11:26:15 INFO - mozfile == 1.2 11:26:15 INFO - mozhttpd == 0.7 11:26:15 INFO - mozinfo == 0.9 11:26:15 INFO - mozleak == 0.1 11:26:15 INFO - mozlog == 3.4 11:26:15 INFO - moznetwork == 0.27 11:26:15 INFO - mozprocess == 0.23 11:26:15 INFO - mozprofile == 0.28 11:26:15 INFO - mozrunner == 6.13 11:26:15 INFO - mozscreenshot == 0.1 11:26:15 INFO - mozsystemmonitor == 0.3 11:26:15 INFO - moztest == 0.8 11:26:15 INFO - mozversion == 1.4 11:26:15 INFO - psutil == 3.1.1 11:26:15 INFO - requests == 1.2.3 11:26:15 INFO - wsgiref == 0.1.2 11:26:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:26:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26: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')]} 11:26:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:16 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 0x1042bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104235570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ee14a72a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040d3d30>, '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 0x103f39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040cbb20>, '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.1ByErFIvFU/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.l7B6taokfG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 11:26:16 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 11:26:16 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 11:26:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ByErFIvFU/Render', 11:26:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:26:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:26:16 INFO - 'HOME': '/Users/cltbld', 11:26:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:26:16 INFO - 'LOGNAME': 'cltbld', 11:26:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:16 INFO - 'MOZ_NO_REMOTE': '1', 11:26:16 INFO - 'NO_EM_RESTART': '1', 11:26:16 INFO - 'PAGER': '/bin/cat', 11:26:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:26:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:16 INFO - 'PWD': '/builds/slave/test', 11:26:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:26:16 INFO - 'SHELL': '/bin/bash', 11:26:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l7B6taokfG/Listeners', 11:26:16 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 11:26:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:26:16 INFO - 'USER': 'cltbld', 11:26:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:26:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:26:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:16 INFO - 'XPC_FLAGS': '0x0', 11:26:16 INFO - 'XPC_SERVICE_NAME': '0', 11:26:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:26:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:16 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)) 11:26:16 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)) 11:26:16 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)) 11:26:16 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)) 11:26:16 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)) 11:26:16 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)) 11:26:16 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)) 11:26:16 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)) 11:26:16 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)) 11:26:16 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)) 11:26:16 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)) 11:26:16 INFO - Cleaning up... 11:26:16 INFO - Return code: 0 11:26:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:26: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')]} 11:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26: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')]} 11:26:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:17 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 0x1042bf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104235570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ee14a72a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040d3d30>, '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 0x103f39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040cbb20>, '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.1ByErFIvFU/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.l7B6taokfG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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 11:26:17 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 11:26:17 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 11:26:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ByErFIvFU/Render', 11:26:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:26:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:26:17 INFO - 'HOME': '/Users/cltbld', 11:26:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:26:17 INFO - 'LOGNAME': 'cltbld', 11:26:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:17 INFO - 'MOZ_NO_REMOTE': '1', 11:26:17 INFO - 'NO_EM_RESTART': '1', 11:26:17 INFO - 'PAGER': '/bin/cat', 11:26:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:26:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:17 INFO - 'PWD': '/builds/slave/test', 11:26:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:26:17 INFO - 'SHELL': '/bin/bash', 11:26:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l7B6taokfG/Listeners', 11:26:17 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 11:26:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:26:17 INFO - 'USER': 'cltbld', 11:26:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:26:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:26:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:17 INFO - 'XPC_FLAGS': '0x0', 11:26:17 INFO - 'XPC_SERVICE_NAME': '0', 11:26:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:26:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:26:17 INFO - Cleaning up... 11:26:17 INFO - Return code: 0 11:26:17 INFO - Running post-action listener: _resource_record_post_action 11:26:17 INFO - Running post-action listener: _start_resource_monitoring 11:26:17 INFO - Starting resource monitoring. 11:26:17 INFO - [mozharness: 2017-01-25 19:26:17.433391Z] Finished create-virtualenv step (success) 11:26:17 INFO - [mozharness: 2017-01-25 19:26:17.434344Z] Running install step. 11:26:17 INFO - Running pre-action listener: _resource_record_pre_action 11:26:17 INFO - Running main action method: install 11:26:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:26:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:26:17 INFO - Reading from file tmpfile_stdout 11:26:17 INFO - Detecting whether we're running mozinstall >=1.0... 11:26:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:26:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:26:17 INFO - Reading from file tmpfile_stdout 11:26:17 INFO - Output received: 11:26:17 INFO - Usage: mozinstall [options] installer 11:26:17 INFO - Options: 11:26:17 INFO - -h, --help show this help message and exit 11:26:17 INFO - -d DEST, --destination=DEST 11:26:17 INFO - Directory to install application into. [default: 11:26:17 INFO - "/builds/slave/test"] 11:26:17 INFO - --app=APP Application being installed. [default: firefox] 11:26:17 INFO - mkdir: /builds/slave/test/build/application 11:26:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:26:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 11:26:39 INFO - Reading from file tmpfile_stdout 11:26:39 INFO - Output received: 11:26:39 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:26:39 INFO - Running post-action listener: _resource_record_post_action 11:26:39 INFO - [mozharness: 2017-01-25 19:26:39.427543Z] Finished install step (success) 11:26:39 INFO - [mozharness: 2017-01-25 19:26:39.427740Z] Running run-tests step. 11:26:39 INFO - Running pre-action listener: _resource_record_pre_action 11:26:39 INFO - Running main action method: run_tests 11:26:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:26:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:26:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:26:39 INFO - 2017-01-25 11:26:39.441 screenresolution[1623:7669] starting screenresolution argv=screenresolution get 11:26:39 INFO - 2017-01-25 11:26:39.444 screenresolution[1623:7669] Display 0: 1600x1200x32@60 11:26:39 INFO - 2017-01-25 11:26:39.450 screenresolution[1624:7672] starting screenresolution argv=screenresolution list 11:26:39 INFO - Available Modes on Display 0 11:26:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:26:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:26:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:26:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:26:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:26:39 INFO - Intel Iris: 11:26:39 INFO - Chipset Model: Intel Iris 11:26:39 INFO - Type: GPU 11:26:39 INFO - Bus: Built-In 11:26:39 INFO - VRAM (Dynamic, Max): 1536 MB 11:26:39 INFO - Vendor: Intel (0x8086) 11:26:39 INFO - Device ID: 0x0a2e 11:26:39 INFO - Revision ID: 0x0009 11:26:39 INFO - Displays: 11:26:39 INFO - Display: 11:26:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:26:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:26:39 INFO - Display Serial Number: 1600x1200 60 11:26:39 INFO - Main Display: Yes 11:26:39 INFO - Mirror: Off 11:26:39 INFO - Online: Yes 11:26:39 INFO - Rotation: Supported 11:26:39 INFO - Return code: 0 11:26:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:26:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:26:39 INFO - Python 2.7.3 11:26:39 INFO - Return code: 0 11:26:39 INFO - grabbing minidump binary from tooltool 11:26:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:39 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040d3d30>, '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 0x103f39db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040cbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:26:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:26:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 11:26:39 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:26:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:26:39 INFO - Return code: 0 11:26:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:26:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:26:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:26:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:26:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:26:39 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/V3XuJdNRThePMmWT_sJM5g/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0083', '--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 11:26:39 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/V3XuJdNRThePMmWT_sJM5g/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0083 --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 11:26:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1ByErFIvFU/Render', 11:26:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:26:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:26:39 INFO - 'HOME': '/Users/cltbld', 11:26:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:26:39 INFO - 'LOGNAME': 'cltbld', 11:26:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:26:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:26:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:39 INFO - 'MOZ_NO_REMOTE': '1', 11:26:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:26:39 INFO - 'NO_EM_RESTART': '1', 11:26:39 INFO - 'PAGER': '/bin/cat', 11:26:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:26:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:39 INFO - 'PWD': '/builds/slave/test', 11:26:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:26:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:26:39 INFO - 'SHELL': '/bin/bash', 11:26:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l7B6taokfG/Listeners', 11:26:39 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 11:26:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:26:39 INFO - 'USER': 'cltbld', 11:26:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:26:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:26:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:39 INFO - 'XPC_FLAGS': '0x0', 11:26:39 INFO - 'XPC_SERVICE_NAME': '0', 11:26:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:26:39 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/V3XuJdNRThePMmWT_sJM5g/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0083', '--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 11:26:40 INFO - mozversion application_buildid: 20170125090232 11:26:40 INFO - mozversion application_changeset: e8e90b0da7c42819565ecbde023b531a8ad95065 11:26:40 INFO - mozversion application_display_name: Firefox 11:26:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:26:40 INFO - mozversion application_name: Firefox 11:26:40 INFO - mozversion application_remotingname: firefox 11:26:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:26:40 INFO - mozversion application_vendor: Mozilla 11:26:40 INFO - mozversion application_version: 52.0 11:26:40 INFO - mozversion platform_buildid: 20170125090232 11:26:40 INFO - mozversion platform_changeset: e8e90b0da7c42819565ecbde023b531a8ad95065 11:26:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:26:40 INFO - mozversion platform_version: 52.0 11:26:40 INFO - using testdate: 1485372400 11:26:40 INFO - actual date: 1485372400 11:26:40 INFO - starting webserver on 'localhost:49244' 11:26:40 INFO - SUITE-START | Running 2 tests 11:26:40 INFO - TEST-START | dromaeo_css 11:26:40 INFO - operating with platform_type : mac_ 11:26:40 INFO - Initialising browser for dromaeo_css test... 11:26:40 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpA6urvp/profile http://localhost:49244/getInfo.html) 11:26:43 INFO - PROCESS | 1634 | 2017-01-25 11:26:43.121 plugin-container[1637:7856] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d47, name = 'com.apple.tsm.portname' 11:26:43 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:26:43 INFO - PROCESS | 1634 | 2017-01-25 11:26:43.122 plugin-container[1637:7856] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9017, name = 'com.apple.CFPasteboardClient' 11:26:43 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:26:43 INFO - PROCESS | 1634 | 2017-01-25 11:26:43.122 plugin-container[1637:7856] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:26:43 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 11:26:43 INFO - PROCESS | 1634 | colorDepth:24 11:26:43 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 11:26:43 INFO - PROCESS | 1634 | __metrics 11:26:43 ERROR - PROCESS | 1634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 11:26:43 INFO - TEST-INFO | 1634: exit 0 11:26:43 INFO - Browser initialized. 11:26:43 INFO - Running cycle 1/1 for dromaeo_css test... 11:26:43 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpA6urvp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:26:46 INFO - PROCESS | 1638 | 2017-01-25 11:26:46.302 plugin-container[1639:7984] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843b, name = 'com.apple.tsm.portname' 11:26:46 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:26:46 INFO - PROCESS | 1638 | 2017-01-25 11:26:46.303 plugin-container[1639:7984] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4607, name = 'com.apple.CFPasteboardClient' 11:26:46 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:26:46 INFO - PROCESS | 1638 | 2017-01-25 11:26:46.303 plugin-container[1639:7984] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:26:56 INFO - PROCESS | 1638 | RSS: Main: 177053696 11:26:56 INFO - PROCESS | 1638 | 11:29:58 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 11:29:59 INFO - PROCESS | 1638 | RSS: Main: 182312960 11:29:59 INFO - PROCESS | 1638 | 11:33:01 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 11:33:02 INFO - PROCESS | 1638 | RSS: Main: 192167936 11:33:02 INFO - PROCESS | 1638 | 11:36:04 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 11:36:05 INFO - PROCESS | 1638 | RSS: Main: 199340032 11:36:05 INFO - PROCESS | 1638 | 11:39:06 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 11:39:07 INFO - PROCESS | 1638 | RSS: Main: 202317824 11:39:07 INFO - PROCESS | 1638 | 11:42:10 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 11:42:10 INFO - PROCESS | 1638 | RSS: Main: 204128256 11:42:10 INFO - PROCESS | 1638 | 11:45:13 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 11:45:13 INFO - PROCESS | 1638 | RSS: Main: 204541952 11:45:13 INFO - PROCESS | 1638 | 11:45:13 INFO - PROCESS | 1638 | __start_tp_report 11:45:13 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 11:45:13 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 11:45:13 INFO - PROCESS | 1638 | |i|pagename|runs| 11:45:13 INFO - PROCESS | 1638 | |0;dojo.html;3547.9001509532063;3549.716022718182;3580.731445141615;3581.946270805937;3615.2588719312544;4674.532546745328;4741.359916411284;5733.770649174028;5786.074228123491;5794.24674792277;5616.410276920926;5758.568107391952;5849.941500584993;5859.9414005860035;5916.290045194572;4066.5970240267134;4407.757573333465;4779.761011949406;5321.281626980347;5416.214648875911;4979.477154898737;5371.59713021523;5427.565794736412;5430.91853622196;5431.972840135793;5148.8929880075775;5172.793088276464;5427.158790387496;5435.510804027636;5480.369757477902;4396.626286765629;5145.356830396182;5270.604704647167;5279.5512381447625;5284.313039304866;5092.9236061459105;5209.479052094798;5215.921761173586;5219;5265.157574788054;5687.971560142214;5695.401982791788;5701.629394089371;5726.885462290773;5730.885382292331;6131.9386806131815;6142.775043102362;6207.068939659042;6292.276388215322;6324.652144132071;6315.305316415191;6318.684065796691;6318.810435686891;6324.747010119636;6331.955227387475;4898.755062246873;5780.104083867007;5882.823515294548;5899.46904778572;5905.852353691193;6260.405261500241;6312.873742525124;6315.810525684236;6321.652309123042;6358.650274234869;6167.753289868355;6193.969030154821;6206.100115483229;6220.595661282002;6268.937310626927;6324.3043265240785;6335.556511044275;6346.904796428057;6352.745890164434;6356.141920840627;6163.722632481549;6172.629642221481;6219.782307619212;6259.217597800275;6267.4986001120715;6274.498040156776;6284.717187726564;6303.621782693053;6304.621722696653;6318.526110541728;4956.4547899731;5005.574526165244;5050.77271522775;5072.721000344943;5073.315102461121;4441.666874984389;4488.775561221926;4502.752348620857;4515.480719717209;4536.8638940831825;5173.896522069537;5892.1161825726485;5985.311689155716;6087.939120608826;6097.512199024068;6169.96915015422;6258.906116408258;6350.872982540323;6362.077498762654;6439.066335381343;5892.499137573354;5997.340292567814;6001.669908155093;6042.577019608585;6130.306415576139;5511.944880551143;5562.777488900399;5562.7774889004795;5582.804601838916;5586.608937374344;6266.185395898504;6466.094746735461;6532.804015879531;6532.967335163294;6536.738530458729;6238.126662267196;6275.3724627536885;6275.497960163085;6289.7169627365965;6320.968395158179;6518.674066296761;6523.478121750154;6524.412802847766;6535.607863528204;6556.475481961527;6298.275698294571;6304.747810087545;6315.621062736067;6328.683565821599;6330;5251.921221181762;5879.529637628894;6121.117656725574;6232.875342493034;6292.622442653455;6210.844728881814;6241.656708881055;6253.687315634291;6271.965125754199;6288.434040936338;6196.783112591038;6198.845028874314;6212.968935155295;6218.471429928507;6232.314445410911;5852.4147585241135;5881.7647294109465;6018.428249316483;6025.638461692312;6056.818295451144;6174.845628859135;6209;6226.533010024357;6255.093011513396;6262.655553944394;6124.969375153096;6126;6133.877322453615;6149.2620885494025;6156.846078848064 11:45:13 INFO - PROCESS | 1638 | |1;ext.html;528.2446102074034;536.3885170905166;548.5392270492786;554.7586799742115;568.428729127227;39996.200075998466;41921.79039104804;41960.16079678408;43442.56557434425;43464.56535434645;38516.42225366622;43201.78399108;43245.27018919247;43327;43497.78251108748;9596.32825702201;9735.221182305433;9763.609455621801;9769.609215631366;9805;9742.756431089208;9790.118889299962;9813.06775856296;9864.457454839981;9922.206223502139;9800.31397802154;9858.507074646239;9877.308588398815;9912.306138570302;9938;9822.772153480815;9827.754306142333;9893.950530247303;9894.356866803706;9921.851172232422;9554.331196816225;9584.952075239578;9623.759406014835;9653.662121825773;9675.322727409084;40644;40772;40773.184536309105;41123;41208.79395603003;2931.2434837699093;3331.584076767364;3405.2848901730417;3428.6563909401843;3455.1362159460136;28852.99014534481;29676.406471870443;29720;29803;30498.84750576233;2924.6254260497744;3152.8265945372996;3341.4152523308326;3350.430426827421;3389.1357703785625;525221;530149;531251;532106;533153;62145.067823982674;62172.68913655493;62338.68830655818;62557.68721156365;62575.6871215641;63544.729105418555;66221.66889165524;66260.66869665717;66536.6692666144;66600.66798664097;14744.55766327012;15164;15263.465778697915;15360;15369.308381122877;11279.323240605427;13253.469861205444;13299.268540230187;13306.600801975763;13347.998900082534;15576.84423155754;18733.437996860117;19436.90281548583;19449.623387277145;19582.412527624194;3390.7456940729544;6417.711202995876;7015.649217539102;7482.064741907262;8207.343412526983;891.3893982621795;901.3104974694364;910.7950711090084;1002.5288114586133;1091.2197778588188;29970.55044174339;30349;30645;30647.66543816733;30721.846390767903;1063.4470075560819;1120.7422292872684;1180.9940950295193;1182.7161481244439;1183.6153250193722;13862.722745545032;16671.49985500437;17179.742303865452;17734.84723492969;17945.820541794677;667706;677766;689683;691646;696051;62098.379016210165;63311;63874.68062659657;64440.35559644437;64518.0322295166;1436.8203974503188;1439.107753193027;1466.6113479927828;1468.6034770611875;1471.8013068235866;29922.401551969273;31583.842080789447;32095.679043209268;32188.19529511781;32221;52019.73990130025;53612.73193634007;53932.460675392744;54292.72853635865;54544.72727636337;604149;609559;614915;618697;620141;40654.79672601618;41235.793821030704;41417.79291103525;43398.34902476529;43586.782066089465;46055.309170361805;46495;46536.76731616456;46546.301805473624;47951.5204847947;34845.47731784076;39297.624583139455;39828.60171398249;39934.80032599935;40014.599854001084;31047.53428698526;39767;39783.80648580547;39787.40318895161;40841.59158408378;37253;38643;39524.40713389244;39540.60459395369;40698.59301406948;32094.35811283808;35102.297954041285;35468.93593192208;35549.466757999166;35579;21478.24826131078;26672;26820.463590728465;26933.461330773665;27182 11:45:13 INFO - PROCESS | 1638 | |2;jquery.html;382.149716879942;383.1819066293466;388.92027134437444;399.860048982856;418.700629050229;11881.584144554943;16639.750403743954;19785.604287914233;20933.05801238944;21147.154113835448;17240.82759172408;20932.790672093273;21110.26114086007;21597.784022159773;21755.021024053956;5885.61743486672;5937.317208521011;6166.691665416712;6227.782027629034;6254.530910181732;5925.170476133345;6078.756849726005;6149.354317796634;6157.7536898524;6197.597156184856;6135.723892424851;6176.135341052256;6202.348753380875;6204.937950620481;6205.596636218631;5239.711815850127;6065.605735627214;6102.420270074336;6183.443490085914;6247.718852651619;6071.392860713938;6111.2666480022235;6114.908276375813;6123.571350005502;6126.203593532857;13540;13702.97227707916;13746.243956582384;13970.930145349208;14011.089279196922;2294.575503531852;2307.665388518672;2367.905283788664;2422.4912768318673;2894.797364184508;10242.590296388136;10540.789184216273;10671.146308295318;10906;10920.781584368347;1922.1062206074103;1944.912478938437;1981.3857704111772;1983.5338695406567;2042.101475350841;123867.380663097;128139.35930320382;132784.336078319;133374;135011;11645.708857278467;11873.346965916784;12033.518659253707;12049.27704337725;12100.939495302644;13495.932520337532;14989.625259368386;15257.38970441192;15261.923690381476;15287.923560382127;7977.521348719096;8498.192671696179;8836.734897953073;8939.240164586083;8970.058143894797;8124.431289809657;8836.425632334007;8851.291896648252;8870.645174193089;8987.640494380152;3876.9418458723144;4689.976550117228;4731.881702957454;4742.762861856893;4801.615870730333;1958.8432925365937;2011.4267433781595;2014.74815648044;2019.6061767955107;2019.9194829325818;301.57477956082255;389.0119097492394;420.8379773787114;840.2227939156256;882.5190271302156;11745.530178792753;12001.819972700416;12151.756964860653;12225.327606981524;12251.93874030642;443.51213664968276;445.1519854676846;448.0903765356332;449.3080655790112;452.0506935435625;6222.191115155001;6281.685915704196;6304.117423560705;6353.205849268841;6354.523410744213;616770;637500.6249937534;638536;643855.7807211027;649095;131150;133079.3346033283;133341;135772.642273576;139736;449.87403527012486;454.4864303337274;457.780265472575;459.88732760473897;460.2429004287928;11111.94444027807;11309.264897781617;11414.429278536207;11442.912923272275;11701.94682478581;50801.74599127129;51011.48988510216;51884.74057629838;52340.691482713235;53629.7318513405;65144;78412.21587784048;80665;80764;81136;5932.851678708067;7255.165655949633;7672.5012874163;8077.434579579373;8333.95833020831;10804.891951080703;10982.725431864268;13209.933950330187;13277.136986095873;13298.667533311358;11197.832032519356;11435.828462572901;11463.942680286546;11560.537578497102;11611.5355385787;8823.294136469196;10015.998400159926;11155.609553665583;11320.6037788677;11497.597584084517;11354.886451135382;11683.415829208676;11695.12286578527;11986;12102.394880255775;7603.505772125015;7721.266479684421;7728.111267204119;7815.960920195363;7828;8279.62741676638;9169.358144930058;11463.254888432226;11732.296062236293;11984.340861252715 11:45:13 INFO - PROCESS | 1638 | |3;mootools.html;1456.3519233940901;1483.4437086092712;1522.2769184637298;1801.1534578747983;1832.3403574713093;7660.195679453661;7921.603919804001;8152.225538573834;8620.267277281422;8623.439476434027;6983.650817459132;8121.91878081219;8388.95805520973;8392.244697977181;8573.742787716363;2380.9166679166233;2399.7240317363553;2426.9271921842374;2427.8786060696984;2438.5732496813075;2364.680768096302;2450.0077468625236;2453.926382208537;2456.0544190486703;2468.0868078810777;2383.52329534093;2414.8913298901593;2427.5023620157826;2431.051889762985;2434.245383930987;1942.669746143159;1972.3984184823623;2372.5492156490213;2401.051584624081;2404.1945948107405;2309.191782875997;2331.9883400583058;2334.568104900599;2342.9297121086393;2374.7031621047367;8362.289205417546;8405.159484051546;8464.915350846475;8494.490330580124;8507.404481686284;5191.740412979336;5279.44565820591;5327.813526526553;5353.03645343838;5357.062514060063;3479.6346383629607;3533.9823300883586;3591.6049234584175;3595.137167079908;3608.314420260142;1058.8464672622504;1060.4220699718594;1084.9728756781064;1099.6700989703056;1111.6887271563976;10649;10741.570337186504;10945.4527273636;11017.83473247902;11020.559177632886;4572.657050721209;4686.109639168547;4758.07217592573;4761.381020467317;4836.927446088312;9599.136077752895;9605.18355939753;9611.183049440737;9634.795650543681;9635.903640963641;5303.231031500488;5336.332958380202;5345.118055520873;5347.679139251657;5363.731813409314;4425.557444255549;4459.710118842329;4630.745309008037;4888.5111488850835;4908.165611845995;3913.726039177287;3938.7636741795586;4017.678585713136;4021.7788021658503;4035.8183881724804;1283.6790802299424;1309.685675437888;1318.7626227279181;1322.8346456692914;1328.7674656935192;914.0813482450095;926.7034548944273;931.9161275485103;939.5584075484511;952.4285428742699;4716.29255611661;5579;5691.487766100988;5760.769569217268;5961.612495187799;849.1211595998112;850.8000619854329;855.234565064264;909.7179874239007;912.6531917871299;3802.429635554689;3909.139989202371;3917.9804100979313;3933.92132157361;3961.801909904493;9977.401355918668;10195.694129176136;10295.74260643475;10309.381437113647;10318.690439286833;10007.599696012077;10046.19630429564;10171.898281017244;10252.64115755945;10313.896861031444;7535.397168226528;7878.369730421553;7982.401319901031;8073.515589064675;8151.266386025286;5647.181158732043;5804.361520232686;5843.357230704534;5914.970425147847;5977.773794586837;7435.367993720594;9278.072192780937;9292.6282948684;9532.904670953201;9570.95214523923;9452.007539208284;9558.761030974281;9576.377535460173;9647.951760241154;9663.951680241555;6789.083473730983;6971.6862741175755;7205.279472052753;7337.229590893093;7469.850602988018;6827.487938404739;7248.456365772483;7864.764057078297;7908.960455197917;8162.918370816454;6512.804615861532;6931.480138989697;7362.447816413897;7370.262973702587;7404.888926665996;5958.433948774859;7176.40503104607;7216.7834964951135;7262.782116536512;7340.192578816219;6335.366463353628;6472.417482426604;6870.896936545856;6899;6964.756233531802;4861;4881.609471242363;4884.682495637772;4925.753712314298;4929.802807887644;4820.493848145894;4880.78036488366;4890.486498917562;4946.629002824874;4974.626902982363 11:45:13 INFO - PROCESS | 1638 | |4;prototype.html;312.8983080498837;316.312021353556;323.1501151970318;326.6227507229148;328.1271816966867;4358.8474403395885;4879.878003049921;5040.344755181826;5326.387465441476;5644.774209031639;4696.765161741908;4981.35242418486;5287.68273903566;5392.703401312926;5400.461782962002;3409.6590340965827;3429.8456569454434;4172.228137794503;4208.580989960545;4209.800206941022;4054.2296963576973;4191.2874811282;4207.537170911197;4225.830966761326;4228.069824638575;3780.451834483998;3811.6950643948417;4137.896552586194;4144.943039524917;4157.459530261061;3443.882012562256;3610.7472476926628;3972.9801350993203;4192.643625291854;4207.221663992172;3329.7180585474525;3385.64450732672;3646.726495512847;3659.432787917877;3669.2478042001326;4650.697704649221;4993.900121997576;5127.897442051175;5180.6373553851245;5265.262863199156;4056.574059723716;4600.148972440109;4733.408323959505;4777.28340748887;4792.448868380146;5209.635325527214;5212.8957420851375;5408.053590621665;5496.31296087989;5714.599868055385;3893.7274390792654;3915.843366265346;3961.8209984508403;4012.9398059029136;4028;4949.480304568005;5942.762289508414;5989.401059894063;6005.729742161569;6039.9396006039815;3387;3714.294284086015;4046.5548789633117;4051.5340735815757;4087.407325937782;3228.870845166214;3399.8780402467128;3555.6799888010205;3680.1535646801385;3711.7958512282084;4134.875953721333;4698.929516057262;4744.857654270378;4749.1926372516755;4756.146312212645;5433.130699088206;5684.687342196136;5700.914486282709;5709.05800542914;5750.482456578928;1091.6724982505216;1266.468083404972;1267.7844766389735;1288.5103660608909;1314.6984485359426;916.9679061232824;920.6409500294891;929.0675395178014;929.4098247612679;930.2929773372285;5140.196254771442;5152.330197074431;5194.35070616173;5257.684538927677;5294.523492885659;4224.282631284512;4776.737279449663;5517.062099443105;5673.716344160132;5703.403047146806;4514.525974772667;4762;5258.605604579672;5353.839384818461;5367.074944155444;2285.7257129144277;2845.772338212938;2896.6958469360834;2957.689442608495;3017.1746093613046;5143.6399452037995;5642.7178641067785;5796.014677504834;6076.870411737958;6169.72488522316;5034.784694734305;5297.417284098746;5838.795642152504;6040.436142675842;6058.394160583906;5896.7936122235515;6178.66017369049;6217.222847144107;6227.408396202263;6229.345918678564;4615.79228934692;5385.649932754359;5875.6474611523445;5923.496502797138;5982.085732565537;4942.703437793743;5405.972970135124;5641.051264115218;5864.794732184353;5884.823035392853;5099.6685215460875;5969.582129250911;6202.72087756043;6257.812265632038;6265.780697675559;3529.6646818552194;3785.6592906638534;3977.2244412339314;3996.3805610130476;3998.9402808255254;4714.834980775657;5332.6000549958135;5618.831435056954;5945.554083443845;6052.334243233153;5484.506394424521;5768.307803063659;5811.593188476766;5845.357010728731;5880.911786323294;4851.830185943475;5483.588730845282;5561.220409468931;5637.943620563742;5840.532757379485;5706.343770466284;5708;5718.971405142947;5774.94225057744;5781.566382521243;5358.678479291255;5765.884682306414;5890.558208134493;5907.734151963258;5913.983868227149;5487.862803429946;5690.500342289545;5737.827865164052;5739.598228124159;5759.280089988752 11:45:13 INFO - PROCESS | 1638 | |5;yui.html;710.5630037526922;781.2929298984419;790.2334735306754;801.763479773467;827.855125353063;12507.874921250785;12838.101332906701;12877.74244515109;12892.484300627975;12912.031597630168;13401.731965360712;13675.247861367621;13783.93108034461;13798.448062077505;13804.309784510759;829.5603330234954;865.8138500222451;871.9607617657189;875.68037666252;879.8768172455862;803.2329125684956;848.7581039403772;856.195176534056;859.3211363023204;859.4113032572676;898.4788822482977;907.9591418386188;920.5167287174254;920.9861852072224;923.187594916476;851.399763166972;876.7457437343163;887.6050157679836;897.0984160918268;897.878786363839;641.3009819296989;654.8559316950264;690.0270618427993;694.0456871801273;696.8118607975819;12504.3747812609;12713.809292860615;12722.173058751245;12813.039022073383;12892.80660790089;11462.885371146349;11910;12077.335746533938;12257.387130643432;12339.62981110568;10465;10638.734031649194;10757.246992710514;10904.454777261184;11036.668899933014;3626.4197728363597;3719.795411252407;3722.3485889969147;3779.9433008504893;3847.2305538892056;83115.16884831195;86296.56851715701;88762.55618721929;93535.06464935331;98080;9277.304202184863;9509.762255943519;10621.725392952894;10934.234603577674;11086.556537738401;20817.479563011046;20976.895115524323;21145.894270528857;21327.253546125812;21430;7858.685652573948;8087.312578430781;8216.671333146727;8282.047564530036;8302;4169.291220492523;4316.546762589883;4449.888752781141;4556.453225612948;4620.630349572026;2887.884484620634;3551.129973156593;3593.2274560968995;3599.4420864766003;3637.7089832813313;665.9533832631669;670.5339788846802;679.4055201698513;680.3196803196803;681.993180068203;622.6855438003779;640.3340525853154;678.7997540725399;686.0571021264832;687.5737043033351;9354.625814967461;9379.577918993526;9783.36408133469;9866.013398660076;9922.40465572068;694.4513834071129;705.4885208224099;707.1514182980444;710.1265443504518;716.0655344775014;4446.044100518404;4492.618127459137;4693.24003498688;4754.928676069792;4759.575551274225;76290;76316;88023.15872627067;101726;126704.36647816886;89993.85021524216;95161.5241923786;95688;98161.509192455;101638.49180754049;90659;95579;96059.51970239964;97904;98450.03099937961;6959.686814093277;7436.256374362521;9169.862452063091;9207.40151890125;9568.56941437623;61555.076673850825;61607.07589386073;61792;62030.68984655048;62158;80000;82447;82579.5871020665;84024;84665.15334846573;10751.731206719895;10991.890081099407;11278.872112788655;11819.517901240835;11889;12554.560590379293;13001.998001998001;13113;13129.409176586885;13159.47362105505;11979.700507487383;12177.269363838199;12185.939070304592;12269.69325766863;12283.324417156784;10198.235132364955;10491.737706557396;11517.712057198638;12121.212121212446;12330.136890417944;12051.879481205426;12057.095717821023;12074.335911524951;12092.758144836878;12481.375931203585;8262.876056859031;10009.449480278654;10399.428031458343;10482.947585262025;11446.42767861587;8497.87253191215;10550.208734344802;10669.314796425026;10682.786344273227;10784 11:45:13 INFO - PROCESS | 1638 | __end_tp_report 11:45:13 INFO - PROCESS | 1638 | __start_cc_report 11:45:13 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,362 11:45:13 INFO - PROCESS | 1638 | __end_cc_report 11:45:13 INFO - PROCESS | 1638 | __startTimestamp1485373513461__endTimestamp 11:45:13 INFO - PROCESS | 1638 | 11:45:13 INFO - PROCESS | 1638 | ------- Summary: start ------- 11:45:13 INFO - PROCESS | 1638 | Number of tests: 6 11:45:13 INFO - PROCESS | 1638 | 11:45:13 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5799.24 Median:6124.97 stddev:679.71 (11.1%) stddev-sans-first:658.45 11:45:13 INFO - PROCESS | 1638 | Values: 3547.9 3549.7 3580.7 3581.9 3615.3 4674.5 4741.4 5733.8 5786.1 5794.2 5616.4 5758.6 5849.9 5859.9 5916.3 4066.6 4407.8 4779.8 5321.3 5416.2 4979.5 5371.6 5427.6 5430.9 5432.0 5148.9 5172.8 5427.2 5435.5 5480.4 4396.6 5145.4 5270.6 5279.6 5284.3 5092.9 5209.5 5215.9 5219.0 5265.2 5688.0 5695.4 5701.6 5726.9 5730.9 6131.9 6142.8 6207.1 6292.3 6324.7 6315.3 6318.7 6318.8 6324.7 6332.0 4898.8 5780.1 5882.8 5899.5 5905.9 6260.4 6312.9 6315.8 6321.7 6358.7 6167.8 6194.0 6206.1 6220.6 6268.9 6324.3 6335.6 6346.9 6352.7 6356.1 6163.7 6172.6 6219.8 6259.2 6267.5 6274.5 6284.7 6303.6 6304.6 6318.5 4956.5 5005.6 5050.8 5072.7 5073.3 4441.7 4488.8 4502.8 4515.5 4536.9 5173.9 5892.1 5985.3 6087.9 6097.5 6170.0 6258.9 6350.9 6362.1 6439.1 5892.5 5997.3 6001.7 6042.6 6130.3 5511.9 5562.8 5562.8 5582.8 5586.6 6266.2 6466.1 6532.8 6533.0 6536.7 6238.1 6275.4 6275.5 6289.7 6321.0 6518.7 6523.5 6524.4 6535.6 6556.5 6298.3 6304.7 6315.6 6328.7 6330.0 5251.9 5879.5 6121.1 6232.9 6292.6 6210.8 6241.7 6253.7 6272.0 6288.4 6196.8 6198.8 6213.0 6218.5 6232.3 5852.4 5881.8 6018.4 6025.6 6056.8 6174.8 6209.0 6226.5 6255.1 6262.7 6125.0 6126.0 6133.9 6149.3 6156.8 11:45:13 INFO - PROCESS | 1638 | 11:45:13 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:74612.92 Median:41222.29 stddev:163856.11 (397.5%) stddev-sans-first:164221.35 11:45:13 INFO - PROCESS | 1638 | Values: 528.2 536.4 548.5 554.8 568.4 39996.2 41921.8 41960.2 43442.6 43464.6 38516.4 43201.8 43245.3 43327.0 43497.8 9596.3 9735.2 9763.6 9769.6 9805.0 9742.8 9790.1 9813.1 9864.5 9922.2 9800.3 9858.5 9877.3 9912.3 9938.0 9822.8 9827.8 9894.0 9894.4 9921.9 9554.3 9585.0 9623.8 9653.7 9675.3 40644.0 40772.0 40773.2 41123.0 41208.8 2931.2 3331.6 3405.3 3428.7 3455.1 28853.0 29676.4 29720.0 29803.0 30498.8 2924.6 3152.8 3341.4 3350.4 3389.1 525221.0 530149.0 531251.0 532106.0 533153.0 62145.1 62172.7 62338.7 62557.7 62575.7 63544.7 66221.7 66260.7 66536.7 66600.7 14744.6 15164.0 15263.5 15360.0 15369.3 11279.3 13253.5 13299.3 13306.6 13348.0 15576.8 18733.4 19436.9 19449.6 19582.4 3390.7 6417.7 7015.6 7482.1 8207.3 891.4 901.3 910.8 1002.5 1091.2 29970.6 30349.0 30645.0 30647.7 30721.8 1063.4 1120.7 1181.0 1182.7 1183.6 13862.7 16671.5 17179.7 17734.8 17945.8 667706.0 677766.0 689683.0 691646.0 696051.0 62098.4 63311.0 63874.7 64440.4 64518.0 1436.8 1439.1 1466.6 1468.6 1471.8 29922.4 31583.8 32095.7 32188.2 32221.0 52019.7 53612.7 53932.5 54292.7 54544.7 604149.0 609559.0 614915.0 618697.0 620141.0 40654.8 41235.8 41417.8 43398.3 43586.8 46055.3 46495.0 46536.8 46546.3 47951.5 34845.5 39297.6 39828.6 39934.8 40014.6 31047.5 39767.0 39783.8 39787.4 40841.6 37253.0 38643.0 39524.4 39540.6 40698.6 32094.4 35102.3 35468.9 35549.5 35579.0 21478.2 26672.0 26820.5 26933.5 27182.0 11:45:13 INFO - PROCESS | 1638 | 11:45:13 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:35658.68 Median:2132.93 stddev:106637.65 (4999.6%) stddev-sans-first:106903.90 11:45:13 INFO - PROCESS | 1638 | Values: 382.1 383.2 388.9 399.9 418.7 11881.6 16639.8 19785.6 20933.1 21147.2 17240.8 20932.8 21110.3 21597.8 21755.0 5885.6 5937.3 6166.7 6227.8 6254.5 5925.2 6078.8 6149.4 6157.8 6197.6 6135.7 6176.1 6202.3 6204.9 6205.6 5239.7 6065.6 6102.4 6183.4 6247.7 6071.4 6111.3 6114.9 6123.6 6126.2 13540.0 13703.0 13746.2 13970.9 14011.1 2294.6 2307.7 2367.9 2422.5 2894.8 10242.6 10540.8 10671.1 10906.0 10920.8 1922.1 1944.9 1981.4 1983.5 2042.1 123867.4 128139.4 132784.3 133374.0 135011.0 11645.7 11873.3 12033.5 12049.3 12100.9 13495.9 14989.6 15257.4 15261.9 15287.9 7977.5 8498.2 8836.7 8939.2 8970.1 8124.4 8836.4 8851.3 8870.6 8987.6 3876.9 4690.0 4731.9 4742.8 4801.6 1958.8 2011.4 2014.7 2019.6 2019.9 301.6 389.0 420.8 840.2 882.5 11745.5 12001.8 12151.8 12225.3 12251.9 443.5 445.2 448.1 449.3 452.1 6222.2 6281.7 6304.1 6353.2 6354.5 616770.0 637500.6 638536.0 643855.8 649095.0 131150.0 133079.3 133341.0 135772.6 139736.0 449.9 454.5 457.8 459.9 460.2 11111.9 11309.3 11414.4 11442.9 11701.9 50801.7 51011.5 51884.7 52340.7 53629.7 65144.0 78412.2 80665.0 80764.0 81136.0 5932.9 7255.2 7672.5 8077.4 8334.0 10804.9 10982.7 13209.9 13277.1 13298.7 11197.8 11435.8 11463.9 11560.5 11611.5 8823.3 10016.0 11155.6 11320.6 11497.6 11354.9 11683.4 11695.1 11986.0 12102.4 7603.5 7721.3 7728.1 7816.0 7828.0 8279.6 9169.4 11463.3 11732.3 11984.3 11:45:13 INFO - PROCESS | 1638 | 11:45:13 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5500.36 Median:5235.59 stddev:2977.97 (56.9%) stddev-sans-first:2970.81 11:45:13 INFO - PROCESS | 1638 | Values: 1456.4 1483.4 1522.3 1801.2 1832.3 7660.2 7921.6 8152.2 8620.3 8623.4 6983.7 8121.9 8389.0 8392.2 8573.7 2380.9 2399.7 2426.9 2427.9 2438.6 2364.7 2450.0 2453.9 2456.1 2468.1 2383.5 2414.9 2427.5 2431.1 2434.2 1942.7 1972.4 2372.5 2401.1 2404.2 2309.2 2332.0 2334.6 2342.9 2374.7 8362.3 8405.2 8464.9 8494.5 8507.4 5191.7 5279.4 5327.8 5353.0 5357.1 3479.6 3534.0 3591.6 3595.1 3608.3 1058.8 1060.4 1085.0 1099.7 1111.7 10649.0 10741.6 10945.5 11017.8 11020.6 4572.7 4686.1 4758.1 4761.4 4836.9 9599.1 9605.2 9611.2 9634.8 9635.9 5303.2 5336.3 5345.1 5347.7 5363.7 4425.6 4459.7 4630.7 4888.5 4908.2 3913.7 3938.8 4017.7 4021.8 4035.8 1283.7 1309.7 1318.8 1322.8 1328.8 914.1 926.7 931.9 939.6 952.4 4716.3 5579.0 5691.5 5760.8 5961.6 849.1 850.8 855.2 909.7 912.7 3802.4 3909.1 3918.0 3933.9 3961.8 9977.4 10195.7 10295.7 10309.4 10318.7 10007.6 10046.2 10171.9 10252.6 10313.9 7535.4 7878.4 7982.4 8073.5 8151.3 5647.2 5804.4 5843.4 5915.0 5977.8 7435.4 9278.1 9292.6 9532.9 9571.0 9452.0 9558.8 9576.4 9648.0 9664.0 6789.1 6971.7 7205.3 7337.2 7469.9 6827.5 7248.5 7864.8 7909.0 8162.9 6512.8 6931.5 7362.4 7370.3 7404.9 5958.4 7176.4 7216.8 7262.8 7340.2 6335.4 6472.4 6870.9 6899.0 6964.8 4861.0 4881.6 4884.7 4925.8 4929.8 4820.5 4880.8 4890.5 4946.6 4974.6 11:45:13 INFO - PROCESS | 1638 | 11:45:13 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4592.02 Median:5147.99 stddev:1445.03 (28.1%) stddev-sans-first:1412.94 11:45:13 INFO - PROCESS | 1638 | Values: 312.9 316.3 323.2 326.6 328.1 4358.8 4879.9 5040.3 5326.4 5644.8 4696.8 4981.4 5287.7 5392.7 5400.5 3409.7 3429.8 4172.2 4208.6 4209.8 4054.2 4191.3 4207.5 4225.8 4228.1 3780.5 3811.7 4137.9 4144.9 4157.5 3443.9 3610.7 3973.0 4192.6 4207.2 3329.7 3385.6 3646.7 3659.4 3669.2 4650.7 4993.9 5127.9 5180.6 5265.3 4056.6 4600.1 4733.4 4777.3 4792.4 5209.6 5212.9 5408.1 5496.3 5714.6 3893.7 3915.8 3961.8 4012.9 4028.0 4949.5 5942.8 5989.4 6005.7 6039.9 3387.0 3714.3 4046.6 4051.5 4087.4 3228.9 3399.9 3555.7 3680.2 3711.8 4134.9 4698.9 4744.9 4749.2 4756.1 5433.1 5684.7 5700.9 5709.1 5750.5 1091.7 1266.5 1267.8 1288.5 1314.7 917.0 920.6 929.1 929.4 930.3 5140.2 5152.3 5194.4 5257.7 5294.5 4224.3 4776.7 5517.1 5673.7 5703.4 4514.5 4762.0 5258.6 5353.8 5367.1 2285.7 2845.8 2896.7 2957.7 3017.2 5143.6 5642.7 5796.0 6076.9 6169.7 5034.8 5297.4 5838.8 6040.4 6058.4 5896.8 6178.7 6217.2 6227.4 6229.3 4615.8 5385.6 5875.6 5923.5 5982.1 4942.7 5406.0 5641.1 5864.8 5884.8 5099.7 5969.6 6202.7 6257.8 6265.8 3529.7 3785.7 3977.2 3996.4 3998.9 4714.8 5332.6 5618.8 5945.6 6052.3 5484.5 5768.3 5811.6 5845.4 5880.9 4851.8 5483.6 5561.2 5637.9 5840.5 5706.3 5708.0 5719.0 5774.9 5781.6 5358.7 5765.9 5890.6 5907.7 5914.0 5487.9 5690.5 5737.8 5739.6 5759.3 11:45:13 INFO - PROCESS | 1638 | 11:45:13 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:20653.17 Median:61699.54 stddev:30629.73 (49.6%) stddev-sans-first:30679.05 11:45:13 INFO - PROCESS | 1638 | Values: 710.6 781.3 790.2 801.8 827.9 12507.9 12838.1 12877.7 12892.5 12912.0 13401.7 13675.2 13783.9 13798.4 13804.3 829.6 865.8 872.0 875.7 879.9 803.2 848.8 856.2 859.3 859.4 898.5 908.0 920.5 921.0 923.2 851.4 876.7 887.6 897.1 897.9 641.3 654.9 690.0 694.0 696.8 12504.4 12713.8 12722.2 12813.0 12892.8 11462.9 11910.0 12077.3 12257.4 12339.6 10465.0 10638.7 10757.2 10904.5 11036.7 3626.4 3719.8 3722.3 3779.9 3847.2 83115.2 86296.6 88762.6 93535.1 98080.0 9277.3 9509.8 10621.7 10934.2 11086.6 20817.5 20976.9 21145.9 21327.3 21430.0 7858.7 8087.3 8216.7 8282.0 8302.0 4169.3 4316.5 4449.9 4556.5 4620.6 2887.9 3551.1 3593.2 3599.4 3637.7 666.0 670.5 679.4 680.3 682.0 622.7 640.3 678.8 686.1 687.6 9354.6 9379.6 9783.4 9866.0 9922.4 694.5 705.5 707.2 710.1 716.1 4446.0 4492.6 4693.2 4754.9 4759.6 76290.0 76316.0 88023.2 101726.0 126704.4 89993.9 95161.5 95688.0 98161.5 101638.5 90659.0 95579.0 96059.5 97904.0 98450.0 6959.7 7436.3 9169.9 9207.4 9568.6 61555.1 61607.1 61792.0 62030.7 62158.0 80000.0 82447.0 82579.6 84024.0 84665.2 10751.7 10991.9 11278.9 11819.5 11889.0 12554.6 13002.0 13113.0 13129.4 13159.5 11979.7 12177.3 12185.9 12269.7 12283.3 10198.2 10491.7 11517.7 12121.2 12330.1 12051.9 12057.1 12074.3 12092.8 12481.4 8262.9 10009.4 10399.4 10482.9 11446.4 8497.9 10550.2 10669.3 10682.8 10784.0 11:45:13 INFO - PROCESS | 1638 | -------- Summary: end -------- 11:45:13 INFO - PROCESS | 1638 | 11:45:14 INFO - TEST-INFO | 1638: exit 0 11:45:14 INFO - TEST-OK | dromaeo_css | took 1114092ms 11:45:14 INFO - TEST-START | kraken 11:45:14 INFO - operating with platform_type : mac_ 11:45:14 INFO - Initialising browser for kraken test... 11:45:14 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpSq1xw2/profile http://localhost:49244/getInfo.html) 11:45:16 INFO - PROCESS | 1651 | 2017-01-25 11:45:16.759 plugin-container[1653:10471] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x464b, name = 'com.apple.tsm.portname' 11:45:16 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:45:16 INFO - PROCESS | 1651 | 2017-01-25 11:45:16.760 plugin-container[1653:10471] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x870b, name = 'com.apple.CFPasteboardClient' 11:45:16 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:45:16 INFO - PROCESS | 1651 | 2017-01-25 11:45:16.761 plugin-container[1653:10471] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:45:16 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 11:45:16 INFO - PROCESS | 1651 | colorDepth:24 11:45:16 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 11:45:16 INFO - PROCESS | 1651 | __metrics 11:45:16 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 11:45:17 INFO - TEST-INFO | 1651: exit 0 11:45:17 INFO - Browser initialized. 11:45:17 INFO - Running cycle 1/1 for kraken test... 11:45:17 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpSq1xw2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:45:20 INFO - PROCESS | 1654 | 2017-01-25 11:45:20.216 plugin-container[1655:10601] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 11:45:20 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:45:20 INFO - PROCESS | 1654 | 2017-01-25 11:45:20.216 plugin-container[1655:10601] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 11:45:20 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:45:20 INFO - PROCESS | 1654 | 2017-01-25 11:45:20.217 plugin-container[1655:10601] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:45:30 INFO - PROCESS | 1654 | RSS: Main: 177315840 11:45:30 INFO - PROCESS | 1654 | 11:45:33 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 11:45:33 INFO - PROCESS | 1654 | RSS: Main: 190255104 11:45:33 INFO - PROCESS | 1654 | 11:45:36 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 11:45:37 INFO - PROCESS | 1654 | RSS: Main: 198238208 11:45:37 INFO - PROCESS | 1654 | 11:45:40 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 11:45:41 INFO - PROCESS | 1654 | RSS: Main: 200216576 11:45:41 INFO - PROCESS | 1654 | 11:45:43 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 11:45:43 INFO - PROCESS | 1654 | RSS: Main: 202264576 11:45:43 INFO - PROCESS | 1654 | 11:45:45 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:45:46 INFO - PROCESS | 1654 | RSS: Main: 202596352 11:45:46 INFO - PROCESS | 1654 | 11:45:49 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 11:45:49 INFO - PROCESS | 1654 | RSS: Main: 206708736 11:45:49 INFO - PROCESS | 1654 | 11:45:52 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 11:45:53 INFO - PROCESS | 1654 | RSS: Main: 206774272 11:45:53 INFO - PROCESS | 1654 | 11:45:56 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 11:45:57 INFO - PROCESS | 1654 | RSS: Main: 206950400 11:45:57 INFO - PROCESS | 1654 | 11:45:58 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:45:59 INFO - PROCESS | 1654 | RSS: Main: 206069760 11:45:59 INFO - PROCESS | 1654 | 11:46:01 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:46:01 INFO - PROCESS | 1654 | RSS: Main: 206102528 11:46:01 INFO - PROCESS | 1654 | 11:46:03 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:46:04 INFO - PROCESS | 1654 | RSS: Main: 206209024 11:46:04 INFO - PROCESS | 1654 | 11:46:07 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:46:08 INFO - PROCESS | 1654 | RSS: Main: 206188544 11:46:08 INFO - PROCESS | 1654 | 11:46:11 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:46:11 INFO - PROCESS | 1654 | RSS: Main: 206548992 11:46:11 INFO - PROCESS | 1654 | 11:46:13 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 11:46:13 INFO - PROCESS | 1654 | RSS: Main: 208224256 11:46:13 INFO - PROCESS | 1654 | 11:46:13 INFO - PROCESS | 1654 | __start_tp_report 11:46:13 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 11:46:13 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 11:46:13 INFO - PROCESS | 1654 | |i|pagename|runs| 11:46:13 INFO - PROCESS | 1654 | |0;ai-astar;105;117;142;173;159;119;118;118;117;117 11:46:13 INFO - PROCESS | 1654 | |1;audio-beat-detection;184;143;144;142;147;97;101;92;121;148 11:46:13 INFO - PROCESS | 1654 | |2;audio-dft;198;202;230;195;233;169;250;260;272;191 11:46:13 INFO - PROCESS | 1654 | |3;audio-fft;82;58;59;81;67;60;51;70;70;56 11:46:13 INFO - PROCESS | 1654 | |4;audio-oscillator;88;70;108;103;78;69;84;69;70;86 11:46:13 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;89;85;88;85;88;86;102;89;136;130 11:46:13 INFO - PROCESS | 1654 | |6;imaging-darkroom;104;93;93;94;121;158;152;94;104;94 11:46:13 INFO - PROCESS | 1654 | |7;imaging-desaturate;88;89;92;89;135;135;84;140;137;120 11:46:13 INFO - PROCESS | 1654 | |8;json-parse-financial;56;55;57;57;59;59;59;60;59;59 11:46:13 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;63;73;78;66;70;68;70;70;71;72 11:46:13 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;84;80;80;84;82;83;80;85;80;82 11:46:13 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;149;162;156;131;132;151;165;159;186;145 11:46:13 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;185;231;230;167;163;183;222;204;165;150 11:46:13 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;65;67;65;67;65;65;67;66;67;68 11:46:13 INFO - PROCESS | 1654 | __end_tp_report 11:46:13 INFO - PROCESS | 1654 | __start_cc_report 11:46:13 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,901 11:46:13 INFO - PROCESS | 1654 | __end_cc_report 11:46:13 INFO - PROCESS | 1654 | __startTimestamp1485373573719__endTimestamp 11:46:13 INFO - PROCESS | 1654 | 11:46:13 INFO - PROCESS | 1654 | ------- Summary: start ------- 11:46:13 INFO - PROCESS | 1654 | Number of tests: 14 11:46:13 INFO - PROCESS | 1654 | 11:46:13 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:128.50 Median:118.50 stddev:21.99 (18.6%) stddev-sans-first:21.62 11:46:13 INFO - PROCESS | 1654 | Values: 105.0 117.0 142.0 173.0 159.0 119.0 118.0 118.0 117.0 117.0 11:46:13 INFO - PROCESS | 1654 | 11:46:13 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:131.90 Median:147.50 stddev:28.78 (19.5%) stddev-sans-first:23.56 11:46:13 INFO - PROCESS | 1654 | Values: 184.0 143.0 144.0 142.0 147.0 97.0 101.0 92.0 121.0 148.0 11:46:13 INFO - PROCESS | 1654 | 11:46:13 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:220.00 Median:231.50 stddev:33.91 (14.6%) stddev-sans-first:35.02 11:46:13 INFO - PROCESS | 1654 | Values: 198.0 202.0 230.0 195.0 233.0 169.0 250.0 260.0 272.0 191.0 11:46:13 INFO - PROCESS | 1654 | 11:46:13 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:65.40 Median:68.50 stddev:10.46 (15.3%) stddev-sans-first:9.21 11:46:13 INFO - PROCESS | 1654 | Values: 82.0 58.0 59.0 81.0 67.0 60.0 51.0 70.0 70.0 56.0 11:46:13 INFO - PROCESS | 1654 | 11:46:13 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:82.50 Median:74.00 stddev:14.19 (19.2%) stddev-sans-first:14.91 11:46:13 INFO - PROCESS | 1654 | Values: 88.0 70.0 108.0 103.0 78.0 69.0 84.0 69.0 70.0 86.0 11:46:13 INFO - PROCESS | 1654 | 11:46:13 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:97.80 Median:87.00 stddev:19.23 (22.1%) stddev-sans-first:20.13 11:46:13 INFO - PROCESS | 1654 | Values: 89.0 85.0 88.0 85.0 88.0 86.0 102.0 89.0 136.0 130.0 11:46:13 INFO - PROCESS | 1654 | 11:46:13 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:110.70 Median:93.00 stddev:24.95 (26.8%) stddev-sans-first:26.34 11:46:13 INFO - PROCESS | 1654 | Values: 104.0 93.0 93.0 94.0 121.0 158.0 152.0 94.0 104.0 94.0 11:46:13 INFO - PROCESS | 1654 | 11:46:13 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:110.90 Median:86.00 stddev:24.35 (28.3%) stddev-sans-first:24.38 11:46:13 INFO - PROCESS | 1654 | Values: 88.0 89.0 92.0 89.0 135.0 135.0 84.0 140.0 137.0 120.0 11:46:13 INFO - PROCESS | 1654 | 11:46:13 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:59.00 stddev:1.63 (2.8%) stddev-sans-first:1.56 11:46:13 INFO - PROCESS | 1654 | Values: 56.0 55.0 57.0 57.0 59.0 59.0 59.0 60.0 59.0 59.0 11:46:13 INFO - PROCESS | 1654 | 11:46:13 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.50 stddev:4.04 (5.7%) stddev-sans-first:3.37 11:46:13 INFO - PROCESS | 1654 | Values: 63.0 73.0 78.0 66.0 70.0 68.0 70.0 70.0 71.0 72.0 11:46:13 INFO - PROCESS | 1654 | 11:46:13 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.50 stddev:1.94 (2.4%) stddev-sans-first:1.92 11:46:13 INFO - PROCESS | 1654 | Values: 84.0 80.0 80.0 84.0 82.0 83.0 80.0 85.0 80.0 82.0 11:46:13 INFO - PROCESS | 1654 | 11:46:13 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:153.60 Median:157.50 stddev:16.21 (10.3%) stddev-sans-first:17.11 11:46:13 INFO - PROCESS | 1654 | Values: 149.0 162.0 156.0 131.0 132.0 151.0 165.0 159.0 186.0 145.0 11:46:13 INFO - PROCESS | 1654 | 11:46:13 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.00 Median:194.50 stddev:29.92 (15.4%) stddev-sans-first:31.68 11:46:13 INFO - PROCESS | 1654 | Values: 185.0 231.0 230.0 167.0 163.0 183.0 222.0 204.0 165.0 150.0 11:46:13 INFO - PROCESS | 1654 | 11:46:13 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:67.00 stddev:1.14 (1.7%) stddev-sans-first:1.12 11:46:13 INFO - PROCESS | 1654 | Values: 65.0 67.0 65.0 67.0 65.0 65.0 67.0 66.0 67.0 68.0 11:46:13 INFO - PROCESS | 1654 | -------- Summary: end -------- 11:46:13 INFO - PROCESS | 1654 | 11:46:14 INFO - TEST-INFO | 1654: exit 0 11:46:14 INFO - TEST-OK | kraken | took 60555ms 11:46:14 INFO - SUITE-END | took 1174s 11:46:14 INFO - Completed test suite (00:19:34) 11:46:14 INFO - javascript benchmark 11:46:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7195.750126386721, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3547.9001509532063, 3549.716022718182, 3580.731445141615, 3581.946270805937, 3615.2588719312544, 4674.532546745328, 4741.359916411284, 5733.770649174028, 5786.074228123491, 5794.24674792277, 5616.410276920926, 5758.568107391952, 5849.941500584993, 5859.9414005860035, 5916.290045194572, 4066.5970240267134, 4407.757573333465, 4779.761011949406, 5321.281626980347, 5416.214648875911, 4979.477154898737, 5371.59713021523, 5427.565794736412, 5430.91853622196, 5431.972840135793, 5148.8929880075775, 5172.793088276464, 5427.158790387496, 5435.510804027636, 5480.369757477902, 4396.626286765629, 5145.356830396182, 5270.604704647167, 5279.5512381447625, 5284.313039304866, 5092.9236061459105, 5209.479052094798, 5215.921761173586, 5219.0, 5265.157574788054, 5687.971560142214, 5695.401982791788, 5701.629394089371, 5726.885462290773, 5730.885382292331, 6131.9386806131815, 6142.775043102362, 6207.068939659042, 6292.276388215322, 6324.652144132071, 6315.305316415191, 6318.684065796691, 6318.810435686891, 6324.747010119636, 6331.955227387475, 4898.755062246873, 5780.104083867007, 5882.823515294548, 5899.46904778572, 5905.852353691193, 6260.405261500241, 6312.873742525124, 6315.810525684236, 6321.652309123042, 6358.650274234869, 6167.753289868355, 6193.969030154821, 6206.100115483229, 6220.595661282002, 6268.937310626927, 6324.3043265240785, 6335.556511044275, 6346.904796428057, 6352.745890164434, 6356.141920840627, 6163.722632481549, 6172.629642221481, 6219.782307619212, 6259.217597800275, 6267.4986001120715, 6274.498040156776, 6284.717187726564, 6303.621782693053, 6304.621722696653, 6318.526110541728, 4956.4547899731, 5005.574526165244, 5050.77271522775, 5072.721000344943, 5073.315102461121, 4441.666874984389, 4488.775561221926, 4502.752348620857, 4515.480719717209, 4536.8638940831825, 5173.896522069537, 5892.1161825726485, 5985.311689155716, 6087.939120608826, 6097.512199024068, 6169.96915015422, 6258.906116408258, 6350.872982540323, 6362.077498762654, 6439.066335381343, 5892.499137573354, 5997.340292567814, 6001.669908155093, 6042.577019608585, 6130.306415576139, 5511.944880551143, 5562.777488900399, 5562.7774889004795, 5582.804601838916, 5586.608937374344, 6266.185395898504, 6466.094746735461, 6532.804015879531, 6532.967335163294, 6536.738530458729, 6238.126662267196, 6275.3724627536885, 6275.497960163085, 6289.7169627365965, 6320.968395158179, 6518.674066296761, 6523.478121750154, 6524.412802847766, 6535.607863528204, 6556.475481961527, 6298.275698294571, 6304.747810087545, 6315.621062736067, 6328.683565821599, 6330.0, 5251.921221181762, 5879.529637628894, 6121.117656725574, 6232.875342493034, 6292.622442653455, 6210.844728881814, 6241.656708881055, 6253.687315634291, 6271.965125754199, 6288.434040936338, 6196.783112591038, 6198.845028874314, 6212.968935155295, 6218.471429928507, 6232.314445410911, 5852.4147585241135, 5881.7647294109465, 6018.428249316483, 6025.638461692312, 6056.818295451144, 6174.845628859135, 6209.0, 6226.533010024357, 6255.093011513396, 6262.655553944394, 6124.969375153096, 6126.0, 6133.877322453615, 6149.2620885494025, 6156.846078848064], "value": 5757.2428979253555, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [528.2446102074034, 536.3885170905166, 548.5392270492786, 554.7586799742115, 568.428729127227, 39996.200075998466, 41921.79039104804, 41960.16079678408, 43442.56557434425, 43464.56535434645, 38516.42225366622, 43201.78399108, 43245.27018919247, 43327.0, 43497.78251108748, 9596.32825702201, 9735.221182305433, 9763.609455621801, 9769.609215631366, 9805.0, 9742.756431089208, 9790.118889299962, 9813.06775856296, 9864.457454839981, 9922.206223502139, 9800.31397802154, 9858.507074646239, 9877.308588398815, 9912.306138570302, 9938.0, 9822.772153480815, 9827.754306142333, 9893.950530247303, 9894.356866803706, 9921.851172232422, 9554.331196816225, 9584.952075239578, 9623.759406014835, 9653.662121825773, 9675.322727409084, 40644.0, 40772.0, 40773.184536309105, 41123.0, 41208.79395603003, 2931.2434837699093, 3331.584076767364, 3405.2848901730417, 3428.6563909401843, 3455.1362159460136, 28852.99014534481, 29676.406471870443, 29720.0, 29803.0, 30498.84750576233, 2924.6254260497744, 3152.8265945372996, 3341.4152523308326, 3350.430426827421, 3389.1357703785625, 525221.0, 530149.0, 531251.0, 532106.0, 533153.0, 62145.067823982674, 62172.68913655493, 62338.68830655818, 62557.68721156365, 62575.6871215641, 63544.729105418555, 66221.66889165524, 66260.66869665717, 66536.6692666144, 66600.66798664097, 14744.55766327012, 15164.0, 15263.465778697915, 15360.0, 15369.308381122877, 11279.323240605427, 13253.469861205444, 13299.268540230187, 13306.600801975763, 13347.998900082534, 15576.84423155754, 18733.437996860117, 19436.90281548583, 19449.623387277145, 19582.412527624194, 3390.7456940729544, 6417.711202995876, 7015.649217539102, 7482.064741907262, 8207.343412526983, 891.3893982621795, 901.3104974694364, 910.7950711090084, 1002.5288114586133, 1091.2197778588188, 29970.55044174339, 30349.0, 30645.0, 30647.66543816733, 30721.846390767903, 1063.4470075560819, 1120.7422292872684, 1180.9940950295193, 1182.7161481244439, 1183.6153250193722, 13862.722745545032, 16671.49985500437, 17179.742303865452, 17734.84723492969, 17945.820541794677, 667706.0, 677766.0, 689683.0, 691646.0, 696051.0, 62098.379016210165, 63311.0, 63874.68062659657, 64440.35559644437, 64518.0322295166, 1436.8203974503188, 1439.107753193027, 1466.6113479927828, 1468.6034770611875, 1471.8013068235866, 29922.401551969273, 31583.842080789447, 32095.679043209268, 32188.19529511781, 32221.0, 52019.73990130025, 53612.73193634007, 53932.460675392744, 54292.72853635865, 54544.72727636337, 604149.0, 609559.0, 614915.0, 618697.0, 620141.0, 40654.79672601618, 41235.793821030704, 41417.79291103525, 43398.34902476529, 43586.782066089465, 46055.309170361805, 46495.0, 46536.76731616456, 46546.301805473624, 47951.5204847947, 34845.47731784076, 39297.624583139455, 39828.60171398249, 39934.80032599935, 40014.599854001084, 31047.53428698526, 39767.0, 39783.80648580547, 39787.40318895161, 40841.59158408378, 37253.0, 38643.0, 39524.40713389244, 39540.60459395369, 40698.59301406948, 32094.35811283808, 35102.297954041285, 35468.93593192208, 35549.466757999166, 35579.0, 21478.24826131078, 26672.0, 26820.463590728465, 26933.461330773665, 27182.0], "value": 20663.569853679142, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.149716879942, 383.1819066293466, 388.92027134437444, 399.860048982856, 418.700629050229, 11881.584144554943, 16639.750403743954, 19785.604287914233, 20933.05801238944, 21147.154113835448, 17240.82759172408, 20932.790672093273, 21110.26114086007, 21597.784022159773, 21755.021024053956, 5885.61743486672, 5937.317208521011, 6166.691665416712, 6227.782027629034, 6254.530910181732, 5925.170476133345, 6078.756849726005, 6149.354317796634, 6157.7536898524, 6197.597156184856, 6135.723892424851, 6176.135341052256, 6202.348753380875, 6204.937950620481, 6205.596636218631, 5239.711815850127, 6065.605735627214, 6102.420270074336, 6183.443490085914, 6247.718852651619, 6071.392860713938, 6111.2666480022235, 6114.908276375813, 6123.571350005502, 6126.203593532857, 13540.0, 13702.97227707916, 13746.243956582384, 13970.930145349208, 14011.089279196922, 2294.575503531852, 2307.665388518672, 2367.905283788664, 2422.4912768318673, 2894.797364184508, 10242.590296388136, 10540.789184216273, 10671.146308295318, 10906.0, 10920.781584368347, 1922.1062206074103, 1944.912478938437, 1981.3857704111772, 1983.5338695406567, 2042.101475350841, 123867.380663097, 128139.35930320382, 132784.336078319, 133374.0, 135011.0, 11645.708857278467, 11873.346965916784, 12033.518659253707, 12049.27704337725, 12100.939495302644, 13495.932520337532, 14989.625259368386, 15257.38970441192, 15261.923690381476, 15287.923560382127, 7977.521348719096, 8498.192671696179, 8836.734897953073, 8939.240164586083, 8970.058143894797, 8124.431289809657, 8836.425632334007, 8851.291896648252, 8870.645174193089, 8987.640494380152, 3876.9418458723144, 4689.976550117228, 4731.881702957454, 4742.762861856893, 4801.615870730333, 1958.8432925365937, 2011.4267433781595, 2014.74815648044, 2019.6061767955107, 2019.9194829325818, 301.57477956082255, 389.0119097492394, 420.8379773787114, 840.2227939156256, 882.5190271302156, 11745.530178792753, 12001.819972700416, 12151.756964860653, 12225.327606981524, 12251.93874030642, 443.51213664968276, 445.1519854676846, 448.0903765356332, 449.3080655790112, 452.0506935435625, 6222.191115155001, 6281.685915704196, 6304.117423560705, 6353.205849268841, 6354.523410744213, 616770.0, 637500.6249937534, 638536.0, 643855.7807211027, 649095.0, 131150.0, 133079.3346033283, 133341.0, 135772.642273576, 139736.0, 449.87403527012486, 454.4864303337274, 457.780265472575, 459.88732760473897, 460.2429004287928, 11111.94444027807, 11309.264897781617, 11414.429278536207, 11442.912923272275, 11701.94682478581, 50801.74599127129, 51011.48988510216, 51884.74057629838, 52340.691482713235, 53629.7318513405, 65144.0, 78412.21587784048, 80665.0, 80764.0, 81136.0, 5932.851678708067, 7255.165655949633, 7672.5012874163, 8077.434579579373, 8333.95833020831, 10804.891951080703, 10982.725431864268, 13209.933950330187, 13277.136986095873, 13298.667533311358, 11197.832032519356, 11435.828462572901, 11463.942680286546, 11560.537578497102, 11611.5355385787, 8823.294136469196, 10015.998400159926, 11155.609553665583, 11320.6037788677, 11497.597584084517, 11354.886451135382, 11683.415829208676, 11695.12286578527, 11986.0, 12102.394880255775, 7603.505772125015, 7721.266479684421, 7728.111267204119, 7815.960920195363, 7828.0, 8279.62741676638, 9169.358144930058, 11463.254888432226, 11732.296062236293, 11984.340861252715], "value": 8641.236021075025, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1456.3519233940901, 1483.4437086092712, 1522.2769184637298, 1801.1534578747983, 1832.3403574713093, 7660.195679453661, 7921.603919804001, 8152.225538573834, 8620.267277281422, 8623.439476434027, 6983.650817459132, 8121.91878081219, 8388.95805520973, 8392.244697977181, 8573.742787716363, 2380.9166679166233, 2399.7240317363553, 2426.9271921842374, 2427.8786060696984, 2438.5732496813075, 2364.680768096302, 2450.0077468625236, 2453.926382208537, 2456.0544190486703, 2468.0868078810777, 2383.52329534093, 2414.8913298901593, 2427.5023620157826, 2431.051889762985, 2434.245383930987, 1942.669746143159, 1972.3984184823623, 2372.5492156490213, 2401.051584624081, 2404.1945948107405, 2309.191782875997, 2331.9883400583058, 2334.568104900599, 2342.9297121086393, 2374.7031621047367, 8362.289205417546, 8405.159484051546, 8464.915350846475, 8494.490330580124, 8507.404481686284, 5191.740412979336, 5279.44565820591, 5327.813526526553, 5353.03645343838, 5357.062514060063, 3479.6346383629607, 3533.9823300883586, 3591.6049234584175, 3595.137167079908, 3608.314420260142, 1058.8464672622504, 1060.4220699718594, 1084.9728756781064, 1099.6700989703056, 1111.6887271563976, 10649.0, 10741.570337186504, 10945.4527273636, 11017.83473247902, 11020.559177632886, 4572.657050721209, 4686.109639168547, 4758.07217592573, 4761.381020467317, 4836.927446088312, 9599.136077752895, 9605.18355939753, 9611.183049440737, 9634.795650543681, 9635.903640963641, 5303.231031500488, 5336.332958380202, 5345.118055520873, 5347.679139251657, 5363.731813409314, 4425.557444255549, 4459.710118842329, 4630.745309008037, 4888.5111488850835, 4908.165611845995, 3913.726039177287, 3938.7636741795586, 4017.678585713136, 4021.7788021658503, 4035.8183881724804, 1283.6790802299424, 1309.685675437888, 1318.7626227279181, 1322.8346456692914, 1328.7674656935192, 914.0813482450095, 926.7034548944273, 931.9161275485103, 939.5584075484511, 952.4285428742699, 4716.29255611661, 5579.0, 5691.487766100988, 5760.769569217268, 5961.612495187799, 849.1211595998112, 850.8000619854329, 855.234565064264, 909.7179874239007, 912.6531917871299, 3802.429635554689, 3909.139989202371, 3917.9804100979313, 3933.92132157361, 3961.801909904493, 9977.401355918668, 10195.694129176136, 10295.74260643475, 10309.381437113647, 10318.690439286833, 10007.599696012077, 10046.19630429564, 10171.898281017244, 10252.64115755945, 10313.896861031444, 7535.397168226528, 7878.369730421553, 7982.401319901031, 8073.515589064675, 8151.266386025286, 5647.181158732043, 5804.361520232686, 5843.357230704534, 5914.970425147847, 5977.773794586837, 7435.367993720594, 9278.072192780937, 9292.6282948684, 9532.904670953201, 9570.95214523923, 9452.007539208284, 9558.761030974281, 9576.377535460173, 9647.951760241154, 9663.951680241555, 6789.083473730983, 6971.6862741175755, 7205.279472052753, 7337.229590893093, 7469.850602988018, 6827.487938404739, 7248.456365772483, 7864.764057078297, 7908.960455197917, 8162.918370816454, 6512.804615861532, 6931.480138989697, 7362.447816413897, 7370.262973702587, 7404.888926665996, 5958.433948774859, 7176.40503104607, 7216.7834964951135, 7262.782116536512, 7340.192578816219, 6335.366463353628, 6472.417482426604, 6870.896936545856, 6899.0, 6964.756233531802, 4861.0, 4881.609471242363, 4884.682495637772, 4925.753712314298, 4929.802807887644, 4820.493848145894, 4880.78036488366, 4890.486498917562, 4946.629002824874, 4974.626902982363], "value": 4481.533316730019, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.8983080498837, 316.312021353556, 323.1501151970318, 326.6227507229148, 328.1271816966867, 4358.8474403395885, 4879.878003049921, 5040.344755181826, 5326.387465441476, 5644.774209031639, 4696.765161741908, 4981.35242418486, 5287.68273903566, 5392.703401312926, 5400.461782962002, 3409.6590340965827, 3429.8456569454434, 4172.228137794503, 4208.580989960545, 4209.800206941022, 4054.2296963576973, 4191.2874811282, 4207.537170911197, 4225.830966761326, 4228.069824638575, 3780.451834483998, 3811.6950643948417, 4137.896552586194, 4144.943039524917, 4157.459530261061, 3443.882012562256, 3610.7472476926628, 3972.9801350993203, 4192.643625291854, 4207.221663992172, 3329.7180585474525, 3385.64450732672, 3646.726495512847, 3659.432787917877, 3669.2478042001326, 4650.697704649221, 4993.900121997576, 5127.897442051175, 5180.6373553851245, 5265.262863199156, 4056.574059723716, 4600.148972440109, 4733.408323959505, 4777.28340748887, 4792.448868380146, 5209.635325527214, 5212.8957420851375, 5408.053590621665, 5496.31296087989, 5714.599868055385, 3893.7274390792654, 3915.843366265346, 3961.8209984508403, 4012.9398059029136, 4028.0, 4949.480304568005, 5942.762289508414, 5989.401059894063, 6005.729742161569, 6039.9396006039815, 3387.0, 3714.294284086015, 4046.5548789633117, 4051.5340735815757, 4087.407325937782, 3228.870845166214, 3399.8780402467128, 3555.6799888010205, 3680.1535646801385, 3711.7958512282084, 4134.875953721333, 4698.929516057262, 4744.857654270378, 4749.1926372516755, 4756.146312212645, 5433.130699088206, 5684.687342196136, 5700.914486282709, 5709.05800542914, 5750.482456578928, 1091.6724982505216, 1266.468083404972, 1267.7844766389735, 1288.5103660608909, 1314.6984485359426, 916.9679061232824, 920.6409500294891, 929.0675395178014, 929.4098247612679, 930.2929773372285, 5140.196254771442, 5152.330197074431, 5194.35070616173, 5257.684538927677, 5294.523492885659, 4224.282631284512, 4776.737279449663, 5517.062099443105, 5673.716344160132, 5703.403047146806, 4514.525974772667, 4762.0, 5258.605604579672, 5353.839384818461, 5367.074944155444, 2285.7257129144277, 2845.772338212938, 2896.6958469360834, 2957.689442608495, 3017.1746093613046, 5143.6399452037995, 5642.7178641067785, 5796.014677504834, 6076.870411737958, 6169.72488522316, 5034.784694734305, 5297.417284098746, 5838.795642152504, 6040.436142675842, 6058.394160583906, 5896.7936122235515, 6178.66017369049, 6217.222847144107, 6227.408396202263, 6229.345918678564, 4615.79228934692, 5385.649932754359, 5875.6474611523445, 5923.496502797138, 5982.085732565537, 4942.703437793743, 5405.972970135124, 5641.051264115218, 5864.794732184353, 5884.823035392853, 5099.6685215460875, 5969.582129250911, 6202.72087756043, 6257.812265632038, 6265.780697675559, 3529.6646818552194, 3785.6592906638534, 3977.2244412339314, 3996.3805610130476, 3998.9402808255254, 4714.834980775657, 5332.6000549958135, 5618.831435056954, 5945.554083443845, 6052.334243233153, 5484.506394424521, 5768.307803063659, 5811.593188476766, 5845.357010728731, 5880.911786323294, 4851.830185943475, 5483.588730845282, 5561.220409468931, 5637.943620563742, 5840.532757379485, 5706.343770466284, 5708.0, 5718.971405142947, 5774.94225057744, 5781.566382521243, 5358.678479291255, 5765.884682306414, 5890.558208134493, 5907.734151963258, 5913.983868227149, 5487.862803429946, 5690.500342289545, 5737.827865164052, 5739.598228124159, 5759.280089988752], "value": 4135.350914059463, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.5630037526922, 781.2929298984419, 790.2334735306754, 801.763479773467, 827.855125353063, 12507.874921250785, 12838.101332906701, 12877.74244515109, 12892.484300627975, 12912.031597630168, 13401.731965360712, 13675.247861367621, 13783.93108034461, 13798.448062077505, 13804.309784510759, 829.5603330234954, 865.8138500222451, 871.9607617657189, 875.68037666252, 879.8768172455862, 803.2329125684956, 848.7581039403772, 856.195176534056, 859.3211363023204, 859.4113032572676, 898.4788822482977, 907.9591418386188, 920.5167287174254, 920.9861852072224, 923.187594916476, 851.399763166972, 876.7457437343163, 887.6050157679836, 897.0984160918268, 897.878786363839, 641.3009819296989, 654.8559316950264, 690.0270618427993, 694.0456871801273, 696.8118607975819, 12504.3747812609, 12713.809292860615, 12722.173058751245, 12813.039022073383, 12892.80660790089, 11462.885371146349, 11910.0, 12077.335746533938, 12257.387130643432, 12339.62981110568, 10465.0, 10638.734031649194, 10757.246992710514, 10904.454777261184, 11036.668899933014, 3626.4197728363597, 3719.795411252407, 3722.3485889969147, 3779.9433008504893, 3847.2305538892056, 83115.16884831195, 86296.56851715701, 88762.55618721929, 93535.06464935331, 98080.0, 9277.304202184863, 9509.762255943519, 10621.725392952894, 10934.234603577674, 11086.556537738401, 20817.479563011046, 20976.895115524323, 21145.894270528857, 21327.253546125812, 21430.0, 7858.685652573948, 8087.312578430781, 8216.671333146727, 8282.047564530036, 8302.0, 4169.291220492523, 4316.546762589883, 4449.888752781141, 4556.453225612948, 4620.630349572026, 2887.884484620634, 3551.129973156593, 3593.2274560968995, 3599.4420864766003, 3637.7089832813313, 665.9533832631669, 670.5339788846802, 679.4055201698513, 680.3196803196803, 681.993180068203, 622.6855438003779, 640.3340525853154, 678.7997540725399, 686.0571021264832, 687.5737043033351, 9354.625814967461, 9379.577918993526, 9783.36408133469, 9866.013398660076, 9922.40465572068, 694.4513834071129, 705.4885208224099, 707.1514182980444, 710.1265443504518, 716.0655344775014, 4446.044100518404, 4492.618127459137, 4693.24003498688, 4754.928676069792, 4759.575551274225, 76290.0, 76316.0, 88023.15872627067, 101726.0, 126704.36647816886, 89993.85021524216, 95161.5241923786, 95688.0, 98161.509192455, 101638.49180754049, 90659.0, 95579.0, 96059.51970239964, 97904.0, 98450.03099937961, 6959.686814093277, 7436.256374362521, 9169.862452063091, 9207.40151890125, 9568.56941437623, 61555.076673850825, 61607.07589386073, 61792.0, 62030.68984655048, 62158.0, 80000.0, 82447.0, 82579.5871020665, 84024.0, 84665.15334846573, 10751.731206719895, 10991.890081099407, 11278.872112788655, 11819.517901240835, 11889.0, 12554.560590379293, 13001.998001998001, 13113.0, 13129.409176586885, 13159.47362105505, 11979.700507487383, 12177.269363838199, 12185.939070304592, 12269.69325766863, 12283.324417156784, 10198.235132364955, 10491.737706557396, 11517.712057198638, 12121.212121212446, 12330.136890417944, 12051.879481205426, 12057.095717821023, 12074.335911524951, 12092.758144836878, 12481.375931203585, 8262.876056859031, 10009.449480278654, 10399.428031458343, 10482.947585262025, 11446.42767861587, 8497.87253191215, 10550.208734344802, 10669.314796425026, 10682.786344273227, 10784.0], "value": 7285.771812514346, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1567.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 117.0, 142.0, 173.0, 159.0, 119.0, 118.0, 118.0, 117.0, 117.0], "value": 128.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 143.0, 144.0, 142.0, 147.0, 97.0, 101.0, 92.0, 121.0, 148.0], "value": 131.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 202.0, 230.0, 195.0, 233.0, 169.0, 250.0, 260.0, 272.0, 191.0], "value": 220.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 59.0, 81.0, 67.0, 60.0, 51.0, 70.0, 70.0, 56.0], "value": 65.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 108.0, 103.0, 78.0, 69.0, 84.0, 69.0, 70.0, 86.0], "value": 82.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 88.0, 85.0, 88.0, 86.0, 102.0, 89.0, 136.0, 130.0], "value": 97.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 93.0, 93.0, 94.0, 121.0, 158.0, 152.0, 94.0, 104.0, 94.0], "value": 110.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 92.0, 89.0, 135.0, 135.0, 84.0, 140.0, 137.0, 120.0], "value": 110.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 57.0, 57.0, 59.0, 59.0, 59.0, 60.0, 59.0, 59.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 73.0, 78.0, 66.0, 70.0, 68.0, 70.0, 70.0, 71.0, 72.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 80.0, 84.0, 82.0, 83.0, 80.0, 85.0, 80.0, 82.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 162.0, 156.0, 131.0, 132.0, 151.0, 165.0, 159.0, 186.0, 145.0], "value": 153.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 231.0, 230.0, 167.0, 163.0, 183.0, 222.0, 204.0, 165.0, 150.0], "value": 190.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 65.0, 67.0, 65.0, 65.0, 67.0, 66.0, 67.0, 68.0], "value": 66.2, "unit": "score"}]}]} 11:46:14 INFO - Return code: 0 11:46:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:46:15 ERROR - # TBPL SUCCESS # 11:46:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:46:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:46:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:46:15 INFO - 2017-01-25 11:46:15.042 screenresolution[1659:10979] starting screenresolution argv=screenresolution get 11:46:15 INFO - 2017-01-25 11:46:15.045 screenresolution[1659:10979] Display 0: 1600x1200x32@60 11:46:15 INFO - 2017-01-25 11:46:15.051 screenresolution[1660:10982] starting screenresolution argv=screenresolution list 11:46:15 INFO - Available Modes on Display 0 11:46:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:46:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:46:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:46:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:46:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:46:15 INFO - Intel Iris: 11:46:15 INFO - Chipset Model: Intel Iris 11:46:15 INFO - Type: GPU 11:46:15 INFO - Bus: Built-In 11:46:15 INFO - VRAM (Dynamic, Max): 1536 MB 11:46:15 INFO - Vendor: Intel (0x8086) 11:46:15 INFO - Device ID: 0x0a2e 11:46:15 INFO - Revision ID: 0x0009 11:46:15 INFO - Displays: 11:46:15 INFO - Display: 11:46:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:46:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:46:15 INFO - Display Serial Number: 1600x1200 60 11:46:15 INFO - Main Display: Yes 11:46:15 INFO - Mirror: Off 11:46:15 INFO - Online: Yes 11:46:15 INFO - Rotation: Supported 11:46:15 INFO - Return code: 0 11:46:15 INFO - Running post-action listener: _resource_record_post_action 11:46:15 INFO - [mozharness: 2017-01-25 19:46:15.291886Z] Finished run-tests step (success) 11:46:15 INFO - Running post-run listener: _resource_record_post_run 11:46:15 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 40491008; Write bytes: 502626304; Read time: 394; Write time: 2241 11:46:15 INFO - TinderboxPrint: CPU usage
54.1% 11:46:15 INFO - TinderboxPrint: I/O read bytes / time
40,491,008 / 394 11:46:15 INFO - TinderboxPrint: I/O write bytes / time
502,626,304 / 2,241 11:46:15 INFO - TinderboxPrint: CPU idle
2,198.1 (45.9%) 11:46:15 INFO - TinderboxPrint: CPU system
969.2 (20.2%) 11:46:15 INFO - TinderboxPrint: CPU user
1,622.5 (33.9%) 11:46:15 INFO - TinderboxPrint: Swap in / out
232,325,120 / 0 11:46:15 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 176857600; Write bytes: 174481408; Read time: 16909; Write time: 320 11:46:15 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 39557120; Write bytes: 309510656; Read time: 379; Write time: 1855 11:46:15 INFO - Running post-run listener: _upload_blobber_files 11:46:15 INFO - Blob upload gear active. 11:46:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:46:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:46:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:46:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:46:16 INFO - (blobuploader) - INFO - Open directory for files ... 11:46:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:46:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:46:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:46:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:46:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:46:18 INFO - (blobuploader) - INFO - Done attempting. 11:46:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:46:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:46:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:46:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:46:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:46:19 INFO - (blobuploader) - INFO - Done attempting. 11:46:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:46:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:46:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:46:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:46:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:46:21 INFO - (blobuploader) - INFO - Done attempting. 11:46:21 INFO - (blobuploader) - INFO - Iteration through files over. 11:46:21 INFO - Return code: 0 11:46:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:46:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:46:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2f409fb661033b5daace9bccff7625c07c3c218da4cccb5d0ecda7efe9f10c5102aba8fada43fe044efe711052e2a8a4284d2478a9cd5b361132b7d78e678251", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/99051608f18c3d8558ee815256636e1b60fcc45fd0de4f2afa6402b7ce5fcb053f595316828a4b67610330a2591258f3562895b9074024dfea0b567166a08625", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4c9641c537a75404e70cc74cf0028b82bfdb8819a91d8742910f8f8660cf7c8dab283a950c6ebb4a8798a0d2de3bf5adc47176a6d190db967c8bee11a086424c"} 11:46:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:46:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:46:21 INFO - Contents: 11:46:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2f409fb661033b5daace9bccff7625c07c3c218da4cccb5d0ecda7efe9f10c5102aba8fada43fe044efe711052e2a8a4284d2478a9cd5b361132b7d78e678251", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/99051608f18c3d8558ee815256636e1b60fcc45fd0de4f2afa6402b7ce5fcb053f595316828a4b67610330a2591258f3562895b9074024dfea0b567166a08625", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4c9641c537a75404e70cc74cf0028b82bfdb8819a91d8742910f8f8660cf7c8dab283a950c6ebb4a8798a0d2de3bf5adc47176a6d190db967c8bee11a086424c"} 11:46:21 INFO - Running post-run listener: copy_logs_to_upload_dir 11:46:21 INFO - Copying logs to upload dir... 11:46:21 INFO - mkdir: /builds/slave/test/build/upload/logs 11:46:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.880118 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-25 11:46:21.421139) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-25 11:46:21.424806) ========= 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.1ByErFIvFU/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.l7B6taokfG/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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/2f409fb661033b5daace9bccff7625c07c3c218da4cccb5d0ecda7efe9f10c5102aba8fada43fe044efe711052e2a8a4284d2478a9cd5b361132b7d78e678251", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/99051608f18c3d8558ee815256636e1b60fcc45fd0de4f2afa6402b7ce5fcb053f595316828a4b67610330a2591258f3562895b9074024dfea0b567166a08625", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4c9641c537a75404e70cc74cf0028b82bfdb8819a91d8742910f8f8660cf7c8dab283a950c6ebb4a8798a0d2de3bf5adc47176a6d190db967c8bee11a086424c"} build_url:https://queue.taskcluster.net/v1/task/V3XuJdNRThePMmWT_sJM5g/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011077 build_url: 'https://queue.taskcluster.net/v1/task/V3XuJdNRThePMmWT_sJM5g/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2f409fb661033b5daace9bccff7625c07c3c218da4cccb5d0ecda7efe9f10c5102aba8fada43fe044efe711052e2a8a4284d2478a9cd5b361132b7d78e678251", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/99051608f18c3d8558ee815256636e1b60fcc45fd0de4f2afa6402b7ce5fcb053f595316828a4b67610330a2591258f3562895b9074024dfea0b567166a08625", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4c9641c537a75404e70cc74cf0028b82bfdb8819a91d8742910f8f8660cf7c8dab283a950c6ebb4a8798a0d2de3bf5adc47176a6d190db967c8bee11a086424c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-25 11:46:21.460267) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 11:46:21.460767) ========= 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.1ByErFIvFU/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.l7B6taokfG/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.005090 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 11:46:21.509840) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-25 11:46:21.510191) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-25 11:46:21.510690) ========= ========= Total master_lag: 0.21 =========