builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0153 starttime: 1479152677.43 results: success (0) buildid: 20161114081542 builduid: c0b4dd1356ae41cf97e49288305ed2d3 revision: f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:37.433731) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:37.434197) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:37.434477) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:37.461767) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:37.462157) ========= 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.bxx9OlTUmC/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.GBQEtZ4NEM/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-14 11:44:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 142M=0s 2016-11-14 11:44:37 (142 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.076539 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:37.560568) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:37.560880) ========= 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.bxx9OlTUmC/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.GBQEtZ4NEM/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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.019779 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:37.613032) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 11:44:37.616433) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d --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-aurora --rev f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bxx9OlTUmC/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.GBQEtZ4NEM/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-14 11:44:37,699 truncating revision to first 12 chars 2016-11-14 11:44:37,699 Setting DEBUG logging. 2016-11-14 11:44:37,700 attempt 1/10 2016-11-14 11:44:37,700 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f11ca24b2382?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 11:44:39,201 unpacking tar archive at: mozilla-aurora-f11ca24b2382/testing/mozharness/ program finished with exit code 0 elapsedTime=1.752821 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 11:44:39.394429) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:39.394808) ========= script_repo_revision: f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:39.395230) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:39.395518) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 11:44:39.414270) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-14 11:44:39.414669) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bxx9OlTUmC/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.GBQEtZ4NEM/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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:44:39 INFO - MultiFileLogger online at 20161114 11:44:39 in /builds/slave/test 11:44:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:44:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:44:39 INFO - {'append_to_log': False, 11:44:39 INFO - 'base_work_dir': '/builds/slave/test', 11:44:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:44:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:44:39 INFO - 'branch': 'Mozilla-Aurora', 11:44:39 INFO - 'buildbot_json_path': 'buildprops.json', 11:44:39 INFO - 'config_files': ('talos/mac_config.py',), 11:44:39 INFO - 'default_actions': ('clobber', 11:44:39 INFO - 'read-buildbot-config', 11:44:39 INFO - 'download-and-extract', 11:44:39 INFO - 'populate-webroot', 11:44:39 INFO - 'create-virtualenv', 11:44:39 INFO - 'install', 11:44:39 INFO - 'run-tests'), 11:44:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:44:39 INFO - 'download_minidump_stackwalk': True, 11:44:39 INFO - 'download_symbols': 'ondemand', 11:44:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:44:39 INFO - 'tooltool.py': '/tools/tooltool.py', 11:44:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:44:39 INFO - '/tools/misc-python/virtualenv.py')}, 11:44:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:44:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:44:39 INFO - 'installer_path': 'installer.exe', 11:44:39 INFO - 'log_level': 'info', 11:44:39 INFO - 'log_name': 'talos', 11:44:39 INFO - 'log_to_console': True, 11:44:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:44:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:44:39 INFO - 'opt_config_files': (), 11:44:39 INFO - 'pip_index': False, 11:44:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:44:39 INFO - 'cmd': ('bash', 11:44:39 INFO - '-c', 11:44:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:44:39 INFO - 'enabled': True, 11:44:39 INFO - 'halt_on_failure': False, 11:44:39 INFO - 'name': 'check_screen_resolution'},), 11:44:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:44:39 INFO - 'cmd': ('bash', 11:44:39 INFO - '-c', 11:44:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:44:39 INFO - 'enabled': True, 11:44:39 INFO - 'halt_on_failure': False, 11:44:39 INFO - 'name': 'check_screen_resolution'},), 11:44:39 INFO - 'run_cmd_checks_enabled': True, 11:44:39 INFO - 'sps_profile': False, 11:44:39 INFO - 'sps_profile_interval': 0, 11:44:39 INFO - 'suite': 'dromaeojs-e10s', 11:44:39 INFO - 'system_bits': '32', 11:44:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:44:39 INFO - 'title': 't-yosemite-r7-0153', 11:44:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:44:39 INFO - 'use_talos_json': True, 11:44:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:44:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:44:39 INFO - 'work_dir': 'build'} 11:44:39 INFO - [mozharness: 2016-11-14 19:44:39.628800Z] Running clobber step. 11:44:39 INFO - Running pre-action listener: _resource_record_pre_action 11:44:39 INFO - Running main action method: clobber 11:44:39 INFO - rmtree: /builds/slave/test/build 11:44:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:44:41 INFO - Running post-action listener: _resource_record_post_action 11:44:41 INFO - [mozharness: 2016-11-14 19:44:41.673470Z] Finished clobber step (success) 11:44:41 INFO - [mozharness: 2016-11-14 19:44:41.673634Z] Running read-buildbot-config step. 11:44:41 INFO - Running pre-action listener: _resource_record_pre_action 11:44:41 INFO - Running main action method: read_buildbot_config 11:44:41 INFO - Using buildbot properties: 11:44:41 INFO - { 11:44:41 INFO - "project": "", 11:44:41 INFO - "product": "firefox", 11:44:41 INFO - "script_repo_revision": "production", 11:44:41 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 11:44:41 INFO - "repository": "", 11:44:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 11:44:41 INFO - "buildid": "20161114081542", 11:44:41 INFO - "pgo_build": "False", 11:44:41 INFO - "basedir": "/builds/slave/test", 11:44:41 INFO - "buildnumber": 160, 11:44:41 INFO - "slavename": "t-yosemite-r7-0153", 11:44:41 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 11:44:41 INFO - "platform": "yosemite_r7", 11:44:41 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 11:44:41 INFO - "branch": "mozilla-aurora", 11:44:41 INFO - "repo_path": "releases/mozilla-aurora", 11:44:41 INFO - "revision": "f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d", 11:44:41 INFO - "stage_platform": "macosx64", 11:44:41 INFO - "builduid": "c0b4dd1356ae41cf97e49288305ed2d3", 11:44:41 INFO - "slavebuilddir": "test" 11:44:41 INFO - } 11:44:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 11:44:41 INFO - Running post-action listener: _resource_record_post_action 11:44:41 INFO - [mozharness: 2016-11-14 19:44:41.677111Z] Finished read-buildbot-config step (success) 11:44:41 INFO - [mozharness: 2016-11-14 19:44:41.677222Z] Running download-and-extract step. 11:44:41 INFO - Running pre-action listener: _resource_record_pre_action 11:44:41 INFO - Running main action method: download_and_extract 11:44:41 INFO - mkdir: /builds/slave/test/build/tests 11:44: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:44:41 INFO - trying https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 11:44:41 INFO - Downloading https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 11:44:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 11:44:42 INFO - Downloaded 1199 bytes. 11:44:42 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 11:44:42 INFO - Using the following test package requirements: 11:44:42 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 11:44:42 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:44:42 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 11:44:42 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:44:42 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 11:44:42 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:44:42 INFO - u'jsshell-mac.zip'], 11:44:42 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:44:42 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 11:44:42 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 11:44:42 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:44:42 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 11:44:42 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:44:42 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 11:44:42 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:44:42 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 11:44:42 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 11:44:42 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 11:44:42 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 11:44:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 11:44:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:44:42 INFO - Fetch https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 11:44:43 INFO - Http code: 200 11:44:43 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 11:44:43 INFO - x-amz-cf-id: 7YnM89z0YJeKgbPfWQN38dX6fRw8ioshWMiBCpwi4kOLDMlLY8epeA== 11:44:43 INFO - x-amz-version-id: beIhMZs6B_1lhCUU5tXTJZFEtB99JGu9 11:44:43 INFO - Expected file size: 16327504 11:44:43 INFO - Obtained file size: 16327504 11:44:50 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 11:44:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 11:44:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:44:50 INFO - Fetch https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 11:44:50 INFO - Http code: 200 11:44:50 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 11:44:50 INFO - x-amz-cf-id: ycM5mFTixWsyGLDiQ-3f44xyZC5ymDf5CBwV7un0WPy_QILf3LEiKQ== 11:44:50 INFO - x-amz-version-id: beIhMZs6B_1lhCUU5tXTJZFEtB99JGu9 11:44:51 INFO - Expected file size: 16327504 11:44:51 INFO - Obtained file size: 16327504 11:44:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 11:44:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 11:44:57 INFO - Fetch https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 11:44:57 INFO - Http code: 200 11:44:57 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 11:44:57 INFO - x-amz-cf-id: YqxTGKOS1slUg6_7kXpcNUly7mCOPfVCUJdpIWeKfmbFit-OoLD7xA== 11:44:57 INFO - x-amz-version-id: fL.n5SYgNX8ZLi3RUYlMNYmEt036hZfV 11:44:58 INFO - Expected file size: 14409038 11:44:58 INFO - Obtained file size: 14409038 11:44:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:58 INFO - trying https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 11:44:58 INFO - Downloading https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 11:44:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 11:45:01 INFO - Downloaded 114359577 bytes. 11:45:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 11:45:01 INFO - mkdir: /builds/slave/test/properties 11:45:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:45:01 INFO - Writing to file /builds/slave/test/properties/build_url 11:45:01 INFO - Contents: 11:45:01 INFO - build_url:https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 11:45:02 INFO - Running post-action listener: _resource_record_post_action 11:45:02 INFO - Running post-action listener: set_extra_try_arguments 11:45:02 INFO - [mozharness: 2016-11-14 19:45:02.073280Z] Finished download-and-extract step (success) 11:45:02 INFO - [mozharness: 2016-11-14 19:45:02.073423Z] Running populate-webroot step. 11:45:02 INFO - Running pre-action listener: _resource_record_pre_action 11:45:02 INFO - Running main action method: populate_webroot 11:45:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:45:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:45:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:45:02 INFO - '--tppagecycles', 11:45:02 INFO - '7'], 11:45:02 INFO - 'tests': ['tsvgm']}}, 11:45:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:45:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:45:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:45:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:45:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:45:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:45:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:45:02 INFO - 'talos_options': ['--disable-e10s'], 11:45:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:45:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:45:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:45:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:45:02 INFO - 'talos_options': ['--disable-e10s'], 11:45:02 INFO - 'tests': ['damp', 'tps']}, 11:45:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:45:02 INFO - 'tests': ['damp', 'tps']}, 11:45:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:45:02 INFO - 'tests': ['dromaeo_dom']}, 11:45:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:45:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:45:02 INFO - 'tests': ['basic_compositor_video']}, 11:45:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:45:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:45:02 INFO - 'tests': ['a11yr', 11:45:02 INFO - 'ts_paint', 11:45:02 INFO - 'tpaint', 11:45:02 INFO - 'sessionrestore', 11:45:02 INFO - 'sessionrestore_no_auto_restore', 11:45:02 INFO - 'tabpaint']}, 11:45:02 INFO - 'other-e10s': {'tests': ['a11yr', 11:45:02 INFO - 'ts_paint', 11:45:02 INFO - 'tpaint', 11:45:02 INFO - 'sessionrestore', 11:45:02 INFO - 'sessionrestore_no_auto_restore', 11:45:02 INFO - 'tabpaint']}, 11:45:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:45:02 INFO - 'ts_paint', 11:45:02 INFO - 'tpaint', 11:45:02 INFO - 'sessionrestore', 11:45:02 INFO - 'sessionrestore_no_auto_restore', 11:45:02 INFO - 'tabpaint']}, 11:45:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:45:02 INFO - 'ts_paint', 11:45:02 INFO - 'tpaint', 11:45:02 INFO - 'sessionrestore', 11:45:02 INFO - 'sessionrestore_no_auto_restore', 11:45:02 INFO - 'tabpaint']}, 11:45:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:45:02 INFO - 'tests': ['a11yr', 11:45:02 INFO - 'ts_paint', 11:45:02 INFO - 'tpaint', 11:45:02 INFO - 'sessionrestore', 11:45:02 INFO - 'sessionrestore_no_auto_restore', 11:45:02 INFO - 'tabpaint']}, 11:45:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:45:02 INFO - 'tests': ['a11yr', 11:45:02 INFO - 'ts_paint', 11:45:02 INFO - 'tpaint', 11:45:02 INFO - 'sessionrestore', 11:45:02 INFO - 'sessionrestore_no_auto_restore', 11:45:02 INFO - 'tabpaint']}, 11:45:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:45:02 INFO - 'tests': ['tsvgx', 11:45:02 INFO - 'tsvgr_opacity', 11:45:02 INFO - 'tart', 11:45:02 INFO - 'tscrollx', 11:45:02 INFO - 'cart']}, 11:45:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:45:02 INFO - 'tsvgr_opacity', 11:45:02 INFO - 'tart', 11:45:02 INFO - 'tscrollx', 11:45:02 INFO - 'cart']}, 11:45:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:45:02 INFO - 'talos_options': ['--disable-e10s'], 11:45:02 INFO - 'tests': ['tp5o']}, 11:45:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:45:02 INFO - 'tests': ['tp5o']}, 11:45:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:45:02 INFO - 'talos_options': ['--disable-e10s', 11:45:02 INFO - '--xperf_path', 11:45:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:45:02 INFO - 'tests': ['tp5n']}, 11:45:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:45:02 INFO - 'talos_options': ['--xperf_path', 11:45:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:45:02 INFO - 'tests': ['tp5n']}}, 11:45:02 INFO - 'talos.zip': {'path': '', 11:45:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:45:02 INFO - Running post-action listener: _resource_record_post_action 11:45:02 INFO - [mozharness: 2016-11-14 19:45:02.091932Z] Finished populate-webroot step (success) 11:45:02 INFO - [mozharness: 2016-11-14 19:45:02.092058Z] Running create-virtualenv step. 11:45:02 INFO - Running pre-action listener: _resource_record_pre_action 11:45:02 INFO - Running main action method: create_virtualenv 11:45:02 INFO - Creating virtualenv /builds/slave/test/build/venv 11:45:02 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:45:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:45:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:45:02 INFO - Using real prefix '/tools/python27' 11:45:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:45:02 INFO - Installing distribute.............................................................................................................................................................................................done. 11:45:05 INFO - Installing pip.................done. 11:45:05 INFO - Return code: 0 11:45:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:45:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:45:06 INFO - Reading from file tmpfile_stdout 11:45:06 INFO - Output received: 11:45:06 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:45:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:45:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108a7d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee435c6690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108891d30>, '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 0x1086f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108889b20>, '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.bxx9OlTUmC/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.GBQEtZ4NEM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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:45:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:45:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:45:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bxx9OlTUmC/Render', 11:45:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:06 INFO - 'HOME': '/Users/cltbld', 11:45:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:06 INFO - 'LOGNAME': 'cltbld', 11:45:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:06 INFO - 'MOZ_NO_REMOTE': '1', 11:45:06 INFO - 'NO_EM_RESTART': '1', 11:45:06 INFO - 'PAGER': '/bin/cat', 11:45:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:06 INFO - 'PWD': '/builds/slave/test', 11:45:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:06 INFO - 'SHELL': '/bin/bash', 11:45:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GBQEtZ4NEM/Listeners', 11:45:06 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 11:45:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:06 INFO - 'USER': 'cltbld', 11:45:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:06 INFO - 'XPC_FLAGS': '0x0', 11:45:06 INFO - 'XPC_SERVICE_NAME': '0', 11:45:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:06 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:45:06 INFO - Cleaning up... 11:45:06 INFO - Return code: 0 11:45:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:45:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108a7d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee435c6690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108891d30>, '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 0x1086f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108889b20>, '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.bxx9OlTUmC/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.GBQEtZ4NEM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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:45:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:45:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:45:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bxx9OlTUmC/Render', 11:45:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:06 INFO - 'HOME': '/Users/cltbld', 11:45:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:06 INFO - 'LOGNAME': 'cltbld', 11:45:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:06 INFO - 'MOZ_NO_REMOTE': '1', 11:45:06 INFO - 'NO_EM_RESTART': '1', 11:45:06 INFO - 'PAGER': '/bin/cat', 11:45:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:06 INFO - 'PWD': '/builds/slave/test', 11:45:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:06 INFO - 'SHELL': '/bin/bash', 11:45:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GBQEtZ4NEM/Listeners', 11:45:06 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 11:45:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:06 INFO - 'USER': 'cltbld', 11:45:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:06 INFO - 'XPC_FLAGS': '0x0', 11:45:06 INFO - 'XPC_SERVICE_NAME': '0', 11:45:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:06 INFO - Downloading/unpacking psutil>=3.1.1 11:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:45:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:45:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:45:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:45:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:45:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:45:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:45:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:45:10 INFO - Installing collected packages: psutil 11:45:10 INFO - Running setup.py install for psutil 11:45:10 INFO - building 'psutil._psutil_osx' extension 11:45:10 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:45:10 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:45:10 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:45:10 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:45:10 INFO - building 'psutil._psutil_posix' extension 11:45:10 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:45:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:45:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:45:10 INFO - ^ 11:45:10 INFO - 1 warning generated. 11:45:10 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:45:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:45:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:45:10 INFO - Successfully installed psutil 11:45:10 INFO - Cleaning up... 11:45:11 INFO - Return code: 0 11:45:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:45:11 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:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:11 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:45:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:11 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 0x108a7d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee435c6690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108891d30>, '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 0x1086f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108889b20>, '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.bxx9OlTUmC/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.GBQEtZ4NEM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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:45:11 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:45:11 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:45:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bxx9OlTUmC/Render', 11:45:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:11 INFO - 'HOME': '/Users/cltbld', 11:45:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:11 INFO - 'LOGNAME': 'cltbld', 11:45:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:11 INFO - 'MOZ_NO_REMOTE': '1', 11:45:11 INFO - 'NO_EM_RESTART': '1', 11:45:11 INFO - 'PAGER': '/bin/cat', 11:45:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:11 INFO - 'PWD': '/builds/slave/test', 11:45:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:11 INFO - 'SHELL': '/bin/bash', 11:45:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GBQEtZ4NEM/Listeners', 11:45:11 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 11:45:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:11 INFO - 'USER': 'cltbld', 11:45:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:11 INFO - 'XPC_FLAGS': '0x0', 11:45:11 INFO - 'XPC_SERVICE_NAME': '0', 11:45:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:45:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:45:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:45:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:45:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:45:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:45:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:45:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:45:13 INFO - Installing collected packages: mozsystemmonitor 11:45:13 INFO - Running setup.py install for mozsystemmonitor 11:45:14 INFO - Successfully installed mozsystemmonitor 11:45:14 INFO - Cleaning up... 11:45:14 INFO - Return code: 0 11:45:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108a7d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee435c6690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108891d30>, '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 0x1086f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108889b20>, '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.bxx9OlTUmC/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.GBQEtZ4NEM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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:45:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:45:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:45:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bxx9OlTUmC/Render', 11:45:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:14 INFO - 'HOME': '/Users/cltbld', 11:45:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:14 INFO - 'LOGNAME': 'cltbld', 11:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:14 INFO - 'MOZ_NO_REMOTE': '1', 11:45:14 INFO - 'NO_EM_RESTART': '1', 11:45:14 INFO - 'PAGER': '/bin/cat', 11:45:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:14 INFO - 'PWD': '/builds/slave/test', 11:45:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:14 INFO - 'SHELL': '/bin/bash', 11:45:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GBQEtZ4NEM/Listeners', 11:45:14 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 11:45:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:14 INFO - 'USER': 'cltbld', 11:45:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:14 INFO - 'XPC_FLAGS': '0x0', 11:45:14 INFO - 'XPC_SERVICE_NAME': '0', 11:45:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:14 INFO - Downloading/unpacking jsonschema==2.5.1 11:45:14 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:45:14 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:45:14 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:45:14 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:45:14 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:45:14 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:45:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:45:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:45:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:45:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:45:17 INFO - Downloading functools32-3.2.3-2.tar.gz 11:45:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:45:17 INFO - warning: no files found matching '*.txt' 11:45:17 INFO - no previously-included directories found matching 'build' 11:45:17 INFO - no previously-included directories found matching 'dist' 11:45:17 INFO - no previously-included directories found matching '.git*' 11:45:17 INFO - Installing collected packages: jsonschema, functools32 11:45:17 INFO - Running setup.py install for functools32 11:45:17 INFO - warning: no files found matching '*.txt' 11:45:17 INFO - no previously-included directories found matching 'build' 11:45:17 INFO - no previously-included directories found matching 'dist' 11:45:17 INFO - no previously-included directories found matching '.git*' 11:45:17 INFO - Successfully installed jsonschema functools32 11:45:17 INFO - Cleaning up... 11:45:17 INFO - Return code: 0 11:45:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:45:17 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:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:17 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:45:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45: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', '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 0x108a7d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee435c6690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108891d30>, '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 0x1086f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108889b20>, '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.bxx9OlTUmC/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.GBQEtZ4NEM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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:45: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:45: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 functools32==3.2.3-2 11:45:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bxx9OlTUmC/Render', 11:45:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:17 INFO - 'HOME': '/Users/cltbld', 11:45:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:17 INFO - 'LOGNAME': 'cltbld', 11:45:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:17 INFO - 'MOZ_NO_REMOTE': '1', 11:45:17 INFO - 'NO_EM_RESTART': '1', 11:45:17 INFO - 'PAGER': '/bin/cat', 11:45:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:17 INFO - 'PWD': '/builds/slave/test', 11:45:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:17 INFO - 'SHELL': '/bin/bash', 11:45:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GBQEtZ4NEM/Listeners', 11:45:17 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 11:45:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:17 INFO - 'USER': 'cltbld', 11:45:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:17 INFO - 'XPC_FLAGS': '0x0', 11:45:17 INFO - 'XPC_SERVICE_NAME': '0', 11:45:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:45:17 INFO - Cleaning up... 11:45:18 INFO - Return code: 0 11:45:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:45:18 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:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:18 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:45:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:18 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 0x108a7d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee435c6690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108891d30>, '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 0x1086f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108889b20>, '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.bxx9OlTUmC/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.GBQEtZ4NEM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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:45:18 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:45:18 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:45:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bxx9OlTUmC/Render', 11:45:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:18 INFO - 'HOME': '/Users/cltbld', 11:45:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:18 INFO - 'LOGNAME': 'cltbld', 11:45:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:18 INFO - 'MOZ_NO_REMOTE': '1', 11:45:18 INFO - 'NO_EM_RESTART': '1', 11:45:18 INFO - 'PAGER': '/bin/cat', 11:45:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:18 INFO - 'PWD': '/builds/slave/test', 11:45:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:18 INFO - 'SHELL': '/bin/bash', 11:45:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GBQEtZ4NEM/Listeners', 11:45:18 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 11:45:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:18 INFO - 'USER': 'cltbld', 11:45:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:18 INFO - 'XPC_FLAGS': '0x0', 11:45:18 INFO - 'XPC_SERVICE_NAME': '0', 11:45:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:18 INFO - Downloading/unpacking blobuploader==1.2.4 11:45:18 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:45:18 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:45:18 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:45:18 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:45:18 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:45:18 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:45:20 INFO - Downloading blobuploader-1.2.4.tar.gz 11:45:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:45:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:45:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:45:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:45:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:45:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:45:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:45:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:45:21 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:45:21 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:45:21 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:45:21 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:45:21 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:45:21 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:45:21 INFO - Downloading docopt-0.6.1.tar.gz 11:45:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:45:22 INFO - Installing collected packages: blobuploader, requests, docopt 11:45:22 INFO - Running setup.py install for blobuploader 11:45:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:45:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:45:22 INFO - Running setup.py install for requests 11:45:22 INFO - Running setup.py install for docopt 11:45:22 INFO - Successfully installed blobuploader requests docopt 11:45:22 INFO - Cleaning up... 11:45:22 INFO - Return code: 0 11:45:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:45: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:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:23 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 0x108a7d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee435c6690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108891d30>, '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 0x1086f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108889b20>, '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.bxx9OlTUmC/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.GBQEtZ4NEM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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:45:23 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:45:23 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:45:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bxx9OlTUmC/Render', 11:45:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:23 INFO - 'HOME': '/Users/cltbld', 11:45:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:23 INFO - 'LOGNAME': 'cltbld', 11:45:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:23 INFO - 'MOZ_NO_REMOTE': '1', 11:45:23 INFO - 'NO_EM_RESTART': '1', 11:45:23 INFO - 'PAGER': '/bin/cat', 11:45:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:23 INFO - 'PWD': '/builds/slave/test', 11:45:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:23 INFO - 'SHELL': '/bin/bash', 11:45:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GBQEtZ4NEM/Listeners', 11:45:23 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 11:45:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:23 INFO - 'USER': 'cltbld', 11:45:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:23 INFO - 'XPC_FLAGS': '0x0', 11:45:23 INFO - 'XPC_SERVICE_NAME': '0', 11:45:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:45:23 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-5Xb6JT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:45:24 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-Q3uLMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:45:24 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-7eA0eA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:45:24 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-vWKhMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:45:24 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-vJYKWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:45:24 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-Pby_tl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:45:24 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-49VW4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:45:24 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-RCufho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:45:24 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-WngYvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:45:24 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-7uJFH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:45:25 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-b9r07W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:45:25 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-zOoFJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:45:25 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-7Ze725-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:45:25 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-EUe9Yz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:45:25 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-zXLeA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:45:25 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-__Xvku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:45:25 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-OpoZGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:45:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:45:25 INFO - Running setup.py install for manifestparser 11:45:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:45:25 INFO - Running setup.py install for mozcrash 11:45:26 INFO - Running setup.py install for mozdebug 11:45:26 INFO - Running setup.py install for mozdevice 11:45:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:45:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:45:26 INFO - Running setup.py install for mozfile 11:45:26 INFO - Running setup.py install for mozhttpd 11:45:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:45:26 INFO - Running setup.py install for mozinfo 11:45:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:45:26 INFO - Running setup.py install for mozInstall 11:45:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:45:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:45:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:45:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:45:26 INFO - Running setup.py install for mozleak 11:45:27 INFO - Running setup.py install for mozlog 11:45:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:45:27 INFO - Running setup.py install for moznetwork 11:45:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:45:27 INFO - Running setup.py install for mozprocess 11:45:27 INFO - Running setup.py install for mozprofile 11:45:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:45:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:45:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:45:27 INFO - Running setup.py install for mozrunner 11:45:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:45:27 INFO - Running setup.py install for mozscreenshot 11:45:28 INFO - Running setup.py install for moztest 11:45:28 INFO - Running setup.py install for mozversion 11:45:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:45:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:45:28 INFO - Cleaning up... 11:45:28 INFO - Return code: 0 11:45:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:45:28 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:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:28 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:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:28 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 0x108a7d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee435c6690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108891d30>, '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 0x1086f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108889b20>, '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.bxx9OlTUmC/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.GBQEtZ4NEM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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:45:28 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:45:28 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:45:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bxx9OlTUmC/Render', 11:45:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:28 INFO - 'HOME': '/Users/cltbld', 11:45:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:28 INFO - 'LOGNAME': 'cltbld', 11:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:28 INFO - 'MOZ_NO_REMOTE': '1', 11:45:28 INFO - 'NO_EM_RESTART': '1', 11:45:28 INFO - 'PAGER': '/bin/cat', 11:45:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:28 INFO - 'PWD': '/builds/slave/test', 11:45:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:28 INFO - 'SHELL': '/bin/bash', 11:45:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GBQEtZ4NEM/Listeners', 11:45:28 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 11:45:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:28 INFO - 'USER': 'cltbld', 11:45:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:28 INFO - 'XPC_FLAGS': '0x0', 11:45:28 INFO - 'XPC_SERVICE_NAME': '0', 11:45:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:45:28 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-oPtSIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:45:29 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:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:45:29 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-g38AHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:45:29 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:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:45:29 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-ZSHlde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:45:29 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:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:45:29 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-lO1pFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:45:29 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:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:45:29 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-yOsEnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:45:29 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:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:45:29 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-_VateS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:45:29 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:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:45:29 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-AhKVbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:45:29 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:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:45:29 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-UHos4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:45:29 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:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:45:29 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-30bOqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:45:29 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:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:45:29 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-ryOki1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:45:30 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:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:45:30 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-LoT562-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:45:30 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:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:45:30 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-JBLuqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:45:30 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:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:45:30 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-RvsuMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:45:30 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:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:45:30 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-KBjXa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:45:30 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:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:45:30 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-q2llah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:45:30 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:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:45:30 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-WlfEn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:45:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:45:30 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-VkoBfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:45:30 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:45:30 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:45:30 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:45:30 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:45:30 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:45:30 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:45:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:45:30 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:45:30 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:45:30 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:45:30 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:45:30 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:45:30 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:45:33 INFO - Downloading blessings-1.6.tar.gz 11:45:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:45:33 INFO - Installing collected packages: blessings 11:45:33 INFO - Running setup.py install for blessings 11:45:33 INFO - Successfully installed blessings 11:45:33 INFO - Cleaning up... 11:45:33 INFO - Return code: 0 11:45:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:45:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:45:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:45:34 INFO - Reading from file tmpfile_stdout 11:45:34 INFO - Current package versions: 11:45:34 INFO - blessings == 1.6 11:45:34 INFO - blobuploader == 1.2.4 11:45:34 INFO - docopt == 0.6.1 11:45:34 INFO - functools32 == 3.2.3-2 11:45:34 INFO - jsonschema == 2.5.1 11:45:34 INFO - manifestparser == 1.1 11:45:34 INFO - mozInstall == 1.12 11:45:34 INFO - mozcrash == 1.0 11:45:34 INFO - mozdebug == 0.1 11:45:34 INFO - mozdevice == 0.48 11:45:34 INFO - mozfile == 1.2 11:45:34 INFO - mozhttpd == 0.7 11:45:34 INFO - mozinfo == 0.9 11:45:34 INFO - mozleak == 0.1 11:45:34 INFO - mozlog == 3.4 11:45:34 INFO - moznetwork == 0.27 11:45:34 INFO - mozprocess == 0.23 11:45:34 INFO - mozprofile == 0.28 11:45:34 INFO - mozrunner == 6.13 11:45:34 INFO - mozscreenshot == 0.1 11:45:34 INFO - mozsystemmonitor == 0.3 11:45:34 INFO - moztest == 0.7 11:45:34 INFO - mozversion == 1.4 11:45:34 INFO - psutil == 3.1.1 11:45:34 INFO - requests == 1.2.3 11:45:34 INFO - wsgiref == 0.1.2 11:45:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:45:34 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:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:34 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:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:34 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 0x108a7d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee435c6690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108891d30>, '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 0x1086f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108889b20>, '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.bxx9OlTUmC/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.GBQEtZ4NEM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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:45:34 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:45:34 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:45:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bxx9OlTUmC/Render', 11:45:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:34 INFO - 'HOME': '/Users/cltbld', 11:45:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:34 INFO - 'LOGNAME': 'cltbld', 11:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:34 INFO - 'MOZ_NO_REMOTE': '1', 11:45:34 INFO - 'NO_EM_RESTART': '1', 11:45:34 INFO - 'PAGER': '/bin/cat', 11:45:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:34 INFO - 'PWD': '/builds/slave/test', 11:45:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:34 INFO - 'SHELL': '/bin/bash', 11:45:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GBQEtZ4NEM/Listeners', 11:45:34 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 11:45:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:34 INFO - 'USER': 'cltbld', 11:45:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:34 INFO - 'XPC_FLAGS': '0x0', 11:45:34 INFO - 'XPC_SERVICE_NAME': '0', 11:45:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:34 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:45:34 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:45:34 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:45:34 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:45:34 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:45:34 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:45:34 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:45:34 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:45:34 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:45:34 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:45:34 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:45:34 INFO - Cleaning up... 11:45:34 INFO - Return code: 0 11:45:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:45:34 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:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:34 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:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:34 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 0x108a7d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089f3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee435c6690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108891d30>, '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 0x1086f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108889b20>, '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.bxx9OlTUmC/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.GBQEtZ4NEM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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:45:34 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:45:34 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:45:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bxx9OlTUmC/Render', 11:45:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:34 INFO - 'HOME': '/Users/cltbld', 11:45:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:34 INFO - 'LOGNAME': 'cltbld', 11:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:34 INFO - 'MOZ_NO_REMOTE': '1', 11:45:34 INFO - 'NO_EM_RESTART': '1', 11:45:34 INFO - 'PAGER': '/bin/cat', 11:45:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:34 INFO - 'PWD': '/builds/slave/test', 11:45:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:34 INFO - 'SHELL': '/bin/bash', 11:45:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GBQEtZ4NEM/Listeners', 11:45:34 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 11:45:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:34 INFO - 'USER': 'cltbld', 11:45:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:34 INFO - 'XPC_FLAGS': '0x0', 11:45:34 INFO - 'XPC_SERVICE_NAME': '0', 11:45:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:45:34 INFO - Cleaning up... 11:45:34 INFO - Return code: 0 11:45:34 INFO - Running post-action listener: _resource_record_post_action 11:45:34 INFO - Running post-action listener: _start_resource_monitoring 11:45:34 INFO - Starting resource monitoring. 11:45:34 INFO - [mozharness: 2016-11-14 19:45:34.573571Z] Finished create-virtualenv step (success) 11:45:34 INFO - [mozharness: 2016-11-14 19:45:34.574586Z] Running install step. 11:45:34 INFO - Running pre-action listener: _resource_record_pre_action 11:45:34 INFO - Running main action method: install 11:45:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:45:34 INFO - Reading from file tmpfile_stdout 11:45:34 INFO - Detecting whether we're running mozinstall >=1.0... 11:45:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:45:34 INFO - Reading from file tmpfile_stdout 11:45:34 INFO - Output received: 11:45:34 INFO - Usage: mozinstall [options] installer 11:45:34 INFO - Options: 11:45:34 INFO - -h, --help show this help message and exit 11:45:34 INFO - -d DEST, --destination=DEST 11:45:34 INFO - Directory to install application into. [default: 11:45:34 INFO - "/builds/slave/test"] 11:45:34 INFO - --app=APP Application being installed. [default: firefox] 11:45:34 INFO - mkdir: /builds/slave/test/build/application 11:45:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 11:46:06 INFO - Reading from file tmpfile_stdout 11:46:06 INFO - Output received: 11:46:06 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 11:46:06 INFO - Running post-action listener: _resource_record_post_action 11:46:06 INFO - [mozharness: 2016-11-14 19:46:06.660894Z] Finished install step (success) 11:46:06 INFO - [mozharness: 2016-11-14 19:46:06.661037Z] Running run-tests step. 11:46:06 INFO - Running pre-action listener: _resource_record_pre_action 11:46:06 INFO - Running main action method: run_tests 11:46:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:46:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:46:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:46:06 INFO - 2016-11-14 11:46:06.675 screenresolution[2362:17957] starting screenresolution argv=screenresolution get 11:46:06 INFO - 2016-11-14 11:46:06.678 screenresolution[2362:17957] Display 0: 1600x1200x32@60 11:46:06 INFO - 2016-11-14 11:46:06.684 screenresolution[2363:17959] starting screenresolution argv=screenresolution list 11:46:06 INFO - Available Modes on Display 0 11:46:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:46:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:46:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:46:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:46:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:46:06 INFO - Intel Iris: 11:46:06 INFO - Chipset Model: Intel Iris 11:46:06 INFO - Type: GPU 11:46:06 INFO - Bus: Built-In 11:46:06 INFO - VRAM (Dynamic, Max): 1536 MB 11:46:06 INFO - Vendor: Intel (0x8086) 11:46:06 INFO - Device ID: 0x0a2e 11:46:06 INFO - Revision ID: 0x0009 11:46:06 INFO - Displays: 11:46:06 INFO - Display: 11:46:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:46:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:46:06 INFO - Display Serial Number: 1600x1200 60 11:46:06 INFO - Main Display: Yes 11:46:06 INFO - Mirror: Off 11:46:06 INFO - Online: Yes 11:46:06 INFO - Rotation: Supported 11:46:06 INFO - Return code: 0 11:46:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:46:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:46:06 INFO - Python 2.7.3 11:46:06 INFO - Return code: 0 11:46:06 INFO - grabbing minidump binary from tooltool 11:46:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:06 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 0x108891d30>, '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 0x1086f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108889b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:46:06 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:46:06 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:46:06 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:46:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:46:07 INFO - Return code: 0 11:46:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:46:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:46:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:46:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:46:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:46:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0153', '--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:46:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0153 --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:46:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bxx9OlTUmC/Render', 11:46:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:46:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:46:07 INFO - 'HOME': '/Users/cltbld', 11:46:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:46:07 INFO - 'LOGNAME': 'cltbld', 11:46:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:46:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:46:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:07 INFO - 'MOZ_NO_REMOTE': '1', 11:46:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:46:07 INFO - 'NO_EM_RESTART': '1', 11:46:07 INFO - 'PAGER': '/bin/cat', 11:46:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:46:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:07 INFO - 'PWD': '/builds/slave/test', 11:46:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:46:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:46:07 INFO - 'SHELL': '/bin/bash', 11:46:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GBQEtZ4NEM/Listeners', 11:46:07 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 11:46:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:46:07 INFO - 'USER': 'cltbld', 11:46:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:46:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:46:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:07 INFO - 'XPC_FLAGS': '0x0', 11:46:07 INFO - 'XPC_SERVICE_NAME': '0', 11:46:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:46:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0153', '--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:46:07 INFO - mozversion application_buildid: 20161114081542 11:46:07 INFO - mozversion application_changeset: f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d 11:46:07 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:46:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:46:07 INFO - mozversion application_name: Firefox 11:46:07 INFO - mozversion application_remotingname: firefox-dev 11:46:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:46:07 INFO - mozversion application_vendor: Mozilla 11:46:07 INFO - mozversion application_version: 52.0a2 11:46:07 INFO - mozversion platform_buildid: 20161114081542 11:46:07 INFO - mozversion platform_changeset: f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d 11:46:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:46:07 INFO - mozversion platform_version: 52.0a2 11:46:07 INFO - using testdate: 1479152767 11:46:07 INFO - actual date: 1479152767 11:46:07 INFO - starting webserver on 'localhost:51425' 11:46:07 INFO - SUITE-START | Running 2 tests 11:46:07 INFO - TEST-START | dromaeo_css 11:46:07 INFO - operating with platform_type : mac_ 11:46:07 INFO - Initialising browser for dromaeo_css test... 11:46:07 INFO - TEST-INFO | started process 2373 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpjkVdiL/profile http://localhost:51425/getInfo.html) 11:46:09 ERROR - PROCESS | 2373 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 11:46:10 INFO - PROCESS | 2373 | __metrics Screen width/height:1600/1200 11:46:10 INFO - PROCESS | 2373 | colorDepth:24 11:46:10 INFO - PROCESS | 2373 | Browser inner width/height: 1024/689 11:46:10 INFO - PROCESS | 2373 | __metrics 11:46:10 ERROR - PROCESS | 2373 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 11:46:10 INFO - TEST-INFO | 2373: exit 0 11:46:10 INFO - Browser initialized. 11:46:10 INFO - Running cycle 1/1 for dromaeo_css test... 11:46:10 INFO - TEST-INFO | started process 2376 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpjkVdiL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:46:22 INFO - PROCESS | 2376 | RSS: Main: 223944704 11:46:22 INFO - PROCESS | 2376 | 11:47:12 INFO - PROCESS | 2376 | 1479152832425 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:49:25 INFO - PROCESS | 2376 | Cycle 1(1): loaded http://localhost:51425/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51425/tests/dromaeo/cssquery-ext.html) 11:49:28 INFO - PROCESS | 2376 | RSS: Main: 235466752 11:49:28 INFO - PROCESS | 2376 | 11:52:30 INFO - PROCESS | 2376 | Cycle 1(1): loaded http://localhost:51425/tests/dromaeo/cssquery-ext.html (next: http://localhost:51425/tests/dromaeo/cssquery-jquery.html) 11:52:31 INFO - PROCESS | 2376 | RSS: Main: 245059584 11:52:31 INFO - PROCESS | 2376 | 11:55:33 INFO - PROCESS | 2376 | Cycle 1(1): loaded http://localhost:51425/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51425/tests/dromaeo/cssquery-mootools.html) 11:55:33 INFO - PROCESS | 2376 | RSS: Main: 250392576 11:55:33 INFO - PROCESS | 2376 | 11:58:35 INFO - PROCESS | 2376 | Cycle 1(1): loaded http://localhost:51425/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51425/tests/dromaeo/cssquery-prototype.html) 11:58:36 INFO - PROCESS | 2376 | RSS: Main: 251609088 11:58:36 INFO - PROCESS | 2376 | 12:01:39 INFO - PROCESS | 2376 | Cycle 1(1): loaded http://localhost:51425/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51425/tests/dromaeo/cssquery-yui.html) 12:01:39 INFO - PROCESS | 2376 | RSS: Main: 255127552 12:01:39 INFO - PROCESS | 2376 | 12:04:42 INFO - PROCESS | 2376 | Cycle 1(1): loaded http://localhost:51425/tests/dromaeo/cssquery-yui.html (next: http://localhost:51425/tests/dromaeo/cssquery-dojo.html) 12:04:42 INFO - PROCESS | 2376 | RSS: Main: 256229376 12:04:42 INFO - PROCESS | 2376 | 12:04:42 INFO - PROCESS | 2376 | __start_tp_report 12:04:42 INFO - PROCESS | 2376 | _x_x_mozilla_page_load 12:04:42 INFO - PROCESS | 2376 | _x_x_mozilla_page_load_details 12:04:42 INFO - PROCESS | 2376 | |i|pagename|runs| 12:04:42 INFO - PROCESS | 2376 | |0;dojo.html;3343.2310568569214;3352.1116904020437;3383.238771276463;3387.1701433148883;3406.2846802171543;5803.506701930336;5879.853003674915;5932.288125424944;5970.373110823366;5985.4912332451795;5967;5998.940010599893;6015.398460153982;6028.336882942884;6033.48715359195;5315.973420132894;5386.974777403888;5415;5443.945560544404;5448.182772584124;5337.599680023995;5453;5456.945430545684;5462.262594549745;5469.617126801126;5217.165253559412;5261.736913154327;5324.41431442541;5366.543843773284;5385.118961355695;4506.346579745951;5253.816116435944;5315.123004704219;5320.334958130234;5322.547583455373;5158.509941555584;5182.663126896739;5235.55497782689;5244.554212891909;5248.107821670325;4944.851654450372;5917.260342457193;5952.345242023374;5984.102384642339;5985.910211346833;6106.236720409949;6149.292831324366;6202.348753380875;6222.751089956397;6241.531885108589;6237.532185086091;6295.276043254993;6296.433321001086;6302.243730752339;6309.558330916838;5868.530517558671;6040.244969378871;6045.1234570987845;6045.486133678643;6097.725602347817;6177.567570270128;6283.717232724538;6310.842228944313;6370.713317900706;6378.712957916905;6148.739508400767;6165.290991536031;6175.62946223219;6184.165137706352;6216.627002379872;6265.404786545271;6305.464035557029;6328.335524769925;6333.936660633335;6335.714892829834;6024.879502409927;6035;6089.482393996472;6106.938930610726;6139.907901381483;6120.938790612126;6124.5712800103565;6129.877402451926;6138.1099740537375;6141.30190404341;4912.9508704913205;4971.030649023478;4991.176455884738;4991.775370108354;4996.575291100225;3717.9256414872093;4186.434831297735;4482.327650852399;4495.123450927038;4496.213162696515;4792.185328494164;5232.2413250078525;5399.622026458111;5635.154726790932;5895.145203945404;5220.034293655686;5234.947650523446;6187.752489900354;6225.28409232935;6247.125402443661;5832.1834943108;5965.582409231399;5966.433188847052;5988.341282458926;6030.276366836008;5498.147787093007;5512.4211957744665;5547.77808887648;5549.223108764776;5552.305961754781;6170.598911070766;6226.782062627786;6240.843978900564;6273.874522509615;6426.2931077581425;6233.781817636361;6260.311365749855;6275.623462592259;6288.905666415099;6299.937000629935;6384.840378990562;6395.616263024233;6405.903911441425;6409.903851442139;6439.613623182624;6137.508999280136;6154.446099851035;6157.630542167305;6224.097505861715;6264.404881536247;6134.478569321657;6140.749659041455;6175.96912015437;6212.0371342441995;6218.626882387071;5147.279380886754;5736.340320863154;6147.385261473817;6196.597221180609;6231.3145553988115;6125.509959203164;6162.26052873658;6189.133521307111;6190.50475961913;6194.938050619436;4805.903881922272;5659.886802264014;6011.849703757441;6039.063945088518;6077.118817771487;6120.508083830795;6144.262688477233;6162.784302549389;6166.352532983972;6177.567570270038;5974;6052.303985041776;6079;6101.6644084574;6131 12:04:42 INFO - PROCESS | 2376 | |1;ext.html;512.3109417833015;513.8895137545427;521.3821621378667;525.9684418934863;548.3146067415732;29401.264968375803;31230.906918257864;31339.529907051412;38381.61618383815;39484.40773388394;40829.18341633165;41143.79428102855;41185.794071029675;41239.79380103095;41498.585014149925;8780.736577902673;9236.44581325121;9392.7651808705;9421.670241541548;9428.905710942905;7596.9240307596765;8029.759107226792;8150;9454;9468.40200723724;9435.669751558697;9438.244940404786;9444.150026497648;9466.763330916714;9488.335816492849;8551.444156129832;9330.813383732288;9375.6718514852;9455.054494550524;9473.952630236874;8153.836923261501;9265.212456941168;9268.72193834186;9330.860037099448;9355.298352623513;38754.61245387538;38948.80525597354;38994;39025.60974390248;39137.02157446058;2901.5502597097275;3333.7166340861054;3376.40912840252;3451.9654803451895;3533.9928120485797;27947.301317467023;28445.85777071122;29462.85268573665;29719.851400743075;30198.84900575505;3150.385674793416;3151.921201969946;3162.256869635634;3175.857086431093;3183.2360233544014;363610;366284;366517;366842;367649;48013.75993120082;55117.1732424014;56145.71927140338;56178.71910640502;56566.717166414724;57049;57151;58307.12539311914;58364.41635583675;58592;14772.48296309624;15782.36870525189;15816.76274855878;15838.683226335408;15879.28543215558;12256.938715306545;12303.815442768366;12308.81536776949;12334.383280835922;12345.753084938251;14398.568042958728;14930.626734331512;15012.099274043592;15054.924725376302;15186.392544298104;3141.5287706844156;5160.767765450564;5688.857778555486;5958.285005799332;5962.433568810956;827.4993628854577;978.2907392140642;1008.2452274246634;1009.3893194617298;1019.0930072235716;24948.37629059288;29758.107256782332;29924.700752992627;29929.102126936228;30164.396712066075;946.7491114854569;1002.0981116994762;1010.5301035018751;1017.2269075502523;1105.911527077848;14966.551003469913;15225.619359515878;15581.376744930303;15608.609784755245;15641.765373519407;679695;687861;687875;687961;697843;55773;56227;56287.02995395223;56502.71748641231;56532;1349.1095876721513;1353.4180302469836;1374.9450021999207;1375.5116933488669;1384.335518950909;28559.85760569554;29079.85460072686;29439.675214614967;29609;30183;48078.27882581834;48126.03747925092;48218.03563928632;48332.27501587409;48395.27407088967;615698;617131;619253;620666;622123;25685.486290273715;26059;26106.73893261043;26130.346741331618;26183.083592074185;44703.776481117384;44960.32559511544;45363;45804.541954580025;46305.3054204194;37887;38328.85013449601;38360.61639383682;38438;39213;29909;33119.50320745239;34889.82555087208;38882.22235555216;39071.63249286261;33052.33895322032;35964.82017589895;37409.81295093507;38253.42619860649;39904.00239994023;31028.0691579253;32025.67974320227;33223.6710531576;34221.82889085539;34728.78449254365;25417.61873571861;25864.741352586232;25970.740292597588;25992.740072599034;26151.823167957107 12:04:42 INFO - PROCESS | 2376 | |2;jquery.html;352.4026774617025;356.39946689827656;371.8419671639553;377.76012232232534;394.498986287415;18069.548261293476;18739;19469.3185738499;19528.902355488237;19710.113044912978;18659.813401865977;18798;19166.904165479187;19287.903560482177;19442;5719.885602287952;5936.495397891184;6001.909971350433;6033.09503574463;6034.306054803688;5634.7182640867795;5913.556483263773;5985.102234664813;6015.849603759897;6019.247594050744;5505.174223866432;5924.348321684612;5970.552208584352;5990.9101363479585;6000.75996960121;5673.716314184295;5809.506191973687;5828.35888052316;5840.591158618899;5860.501857342131;5547.278853748987;5626.409227031185;5643.435656434323;5894.086416605433;5950.4644581987395;12695.873041269653;12768.80846787299;12914.54799082037;12944.482220711161;23605.173818916257;1815.4372144635206;2038.6126635939124;2179.1283486605325;2192.408049826538;2256.7291924968945;8628.266597339234;9601.327907046509;9969.750756231153;10012.199024078056;10329.690109296658;1634.6730653869154;1797.5506123469133;1856.8700190986635;1888.9622207555772;1916.2430839818333;120876;126251;127516.0872586912;128164.87340506368;131970.34014829865;11337.145370574044;11340.773184536263;11760.58837940668;11867;12040.879591203975;14512.1292722437;14537.709245815024;14552.708945821025;14576.854231457763;14587.489437869624;7221.6750246238;8347.83304333922;8458.238758511763;8461.280791132822;8588;8338.916610833936;8341.874871876928;8352.16478352172;8402.663893444194;8535.402521823413;3824.4454554089502;4426.247537918562;4429.689921705514;4520.932186017212;4556;1834.132763376986;1918.9712154317697;1919.673655478572;1923.9519012024812;1942.77658069321;803.5941849366033;905.8777065096259;919.737874705719;935;962.831504486712;19871.40385788429;20973.265935692176;21140;21187.9406029701;21253.68119478209;865.5326123893027;909.1726528858707;921.447131720962;935.8455854783884;966.9758256043655;5915.674637894871;6083.300420451616;6265.498760099181;6288.245410550763;10627.787444251071;380330;380642.0967895143;382188;465344;588146;104037;111984;120284.59430811334;132547;134429.32785336208;431.95896389842915;445.9564618792042;446.91508613363357;447.87011766587324;450.2480856968804;11093.44532773342;11365.977062064454;11425.714357141138;11610.767784644091;11730.589429369931;53693.65765855885;53745.19382209348;54056.459435405144;55171.72414137904;56737.43262567487;76026.61986690252;78609;78788;80197.19802801897;80521.59739201267;7949.960250198712;8119.83760324802;8275.95862020686;8321;8358.582070896553;10810.56757729682;12887.226766394046;12906.967442604757;13008.544700935421;13185.802212967004;5384.784608615611;7632.809179770328;8539.359548034046;10945;11053.447327633747;10252.38485690861;10312;10571.36571805694;10791.460426978776;10947.178961577754;10013.648157498936;10618.415987120474;11192.888071119185;11201.21591488588;11490.425478726198;6882;7946.40401969843;8117.863499110012;8239.464434811718;8272;10592.523336449724;10814.945925270324;10831.708031225915;10984.945075274572;11038.558457661604 12:04:42 INFO - PROCESS | 2376 | |3;mootools.html;1352.9255890926;1495.9925200374;1503.2784263553494;1798.5863251452158;1828.259554880274;7576.621168941559;7843.294103530696;8095.150009249032;8507.404481686284;8553.187447192515;8048.436609437342;8344.45761025533;8355.415120941536;8461.830763384729;8489.745307640766;2344.9648255276184;2360.44529535559;2366.526694661066;2370.596998510249;2382.642603609455;2369.2892132360307;2386.3914701751114;2422.1159276863996;2422.2612103308484;2426.745191754867;1995.8503112266565;2344.284993077111;2368.7749663781915;2378.0963233971065;2380.1907351500486;2196.1105752170397;2221.922232721855;2224.7552769195377;2237.038073628339;2239.014833473283;2263.841531092824;2317.304808557426;2320.303908827345;2333.5449587330477;2339.7426283108844;8357.414980951336;8394.706185283547;8459.857919180893;8471.364647651451;8509.829803403898;5043.9747801260755;5203.713795741232;5210.921836172461;5220.112580861225;5230;3068.6624471308137;3300.2574420755377;3303.8348082595776;3306.8842590509216;3308.2721801203697;1049.1763965287214;1060.7719340341864;1082.8754693210303;1103.0238239158323;1104.8011357955565;9431;10853.565857365697;10983.505742241618;10996.560137594486;11014.559417623286;4434.600885920283;4471.1728330259;4531.161735078955;4540.954590454053;4739.573438390561;9308.162265396011;9394.201492873046;9401.435913845191;9414.340996130342;9424.717258482257;5156.4070131935305;5179.274901513716;5180.248863914711;5184.792608295701;5185.325907631984;4220.767857767853;4237.046664500463;4688.062387522509;4732.361131247238;4746.38297021385;3802.961970380316;3845.673117784964;3902.3366027774778;3917.3144699678014;3947.8618248361167;1188.6968822950093;1237.2761934268374;1277.8786015328528;1291.593148158327;1307.6462367738034;766.4328396986301;778.8442311537715;809.4212637963884;887.729242581019;901.8557030875029;5446.91829622556;5526.4197259288;5642.238297829823;5676.744546495418;5712;454.470541818784;454.4887002122612;456.07644519847577;945.4610871803144;973.5813600151861;3456.701293639752;3739.9439008414897;3787.659110679997;3802.2205447883116;3812.7712337259854;9167.899852017801;9617.23062155026;9812.803743925082;9940.45327506994;10204;7143.214246432888;8172.754817355489;8685.827413299125;9034.819303614022;9900.80198396028;7642.885356719654;7646.464747467735;7838.21617838223;7929.048514178336;7941.523508589503;4548.408706868086;5054.29239906406;5168.604476791321;5503.147012213113;5670.659760414388;7502.624868756649;8145.51126932386;9431.339806213773;9432.434053956784;9442.339036267394;7722.266384693445;8166.387520936072;9323.813523729352;9506.239500840054;9600.85598716006;6601.207855057424;6846.657667116724;7004.3696067354185;7123.7506687265695;7282.417406607353;7822.4524283299625;7846.843063138819;7900.170482099296;7909;7923.524588524707;6959.617221052688;7147.106611673541;7155.928440715526;7164.032855564432;7207.855842883008;6950.131233595801;7032.929670703227;7109.360157585842;7117.8932316016335;7188.568685878864;6621.569597976309;6707.262201157966;6738.898916516158;6742.898856517058;6745.696443660146;4748.192807222711;4830.2513110467935;4842.443119041214;4847.5394837490385;4889.682170658896;4776.164171269945;4776.761161941959;4915.852524424273;4922.4339200992345;4949.901001980013 12:04:42 INFO - PROCESS | 2376 | |4;prototype.html;302.8334416071162;306.37040880989565;307.67079225228986;313.44520199247324;314.9889753858615;4690.765461726917;4849.41806983162;5407.755781350735;5521.365043020049;5663.886722265557;4435.9556404436025;4800.5679488846;4890.193118135503;5314.681119132854;5547.944520554794;4176;4197.559256278085;4201.159768046387;4211.831526738927;4226.400763530437;3919.823607937635;4140.772257525835;4230.830766769341;4233.74597524148;4249.767567405449;4137.813798379065;4152.792360381984;4159.916801663965;4168.937465938014;4172.16556688662;3489.9825500872334;3494.860205591773;3818.8472461101524;4169.3954376615375;4177.26897792885;3599.4420864766003;3607.6933460655614;3617.186133120027;3618.1316484043905;3624.2422425123796;5294.947050529484;5311.601629877775;5364.624476286662;5380.273663055476;5451.373092094381;4596.241620132674;4753.572178503951;4821.734804585746;4822.590079843218;4843.854684359475;5166.43169251382;5170.844874653766;5555.611107222496;5827.532618092228;5878.265216847894;3147.8268695221755;3228.0315905228335;3363.360961417323;3548.432250839853;3978.840846366171;5638.9004144191895;5692.48767610917;5864.76540938362;6112;6211;3606.747527673038;3813.466114743938;3980.0447892506168;4009.4386785850006;4063.5733248008532;3552;3945.7706395886235;4021.276170289376;4068.1863627274665;4098.385242213632;4393.846215382447;4497.572730590588;4525.800662824354;4814.181589129857;4831.178699621073;5099.87250318745;5477.20580515823;5934.1692163097205;5966.373530779292;6063.605865618721;1208.5407545132969;1238.3065483329365;1250.662321173278;1252.6596541700294;1297.6107167849607;805.9200671100754;808.975730728079;815.4984684419039;828.1676914700687;891.791622351717;4612.303804801068;4666.5533684557895;4875.780589873464;5353.250544923714;5362.597805164628;4872.4640289568115;5152.845414637567;5342.732863356817;5781.566382521328;5807.419258074159;4574.30116231425;5200.869978250574;5363.678179309254;5375.951689420525;5386.676799392049;2678.7321267873444;2683.3828219509232;2821.6190814239817;3023.6069310989433;3055.4194703006356;5425.074098694985;5703.178870157005;5805.82582522525;6009.45914867664;6126.927787637145;5082.204787367007;5374.650647707965;5512;5670.971645141748;5734.713264336767;5249.868753281198;5418.051840927901;5541.473560011793;6051.727672254759;6089.817305480754;5449.64577302474;5645.943540564706;5656.971715141398;5857.326407463196;5861.007257532459;4754.049190162051;5356.393082075284;5439.504136362374;5678.630888992202;5719.885602287848;5125.487451254994;5665.405132461032;6019.4883434908525;6049.879002419839;6073.722354117206;3342.431786596333;3689.0448062526903;3699;3854.768713877176;3878.301905657009;4990.9750451248965;5167.34644913624;5463.644863083887;5750.741216645345;5800.477956983892;5738.971305143615;5740.885182296414;5912.172295878494;5925.496332811759;5948.226730525177;4976.925346119739;5010.273510340907;5753.108268218432;5872.647641141545;5901.93432298692;4431.4903786065015;5728.942710572841;5772.624779389326;5791.681457519709;5797.971010144923;4771.73755443454;5588.792426991397;5850.2102216200265;5865.856158049311;5913.172155898264;5238.738063096906;5364.758585863724;5761.596688231783;5796.971015145066;5817.894600025981 12:04:42 INFO - PROCESS | 2376 | |5;yui.html;677.8745932002577;679.9252082270951;701.642162497127;713.4078714666826;738.6417587470077;10689.984451477107;13707.862921370795;14676.779848302258;14692.191929443903;14763.483278085268;12877.678058048554;13167.209967401963;13437.462501499953;13616.659583510418;13678.247696376695;644.7904431059901;816.1185919207242;833.5748768128237;837.8952630921135;838.7316058861167;672.9831754206159;727.5343779980816;827.3174630929477;833.8082241084554;838.9203025712548;869.430523007428;874.623911717961;879.4855009819263;879.9648014079429;881.5548148185158;869.1829680100685;873.7597160780773;875.2210532625968;877.7015814623027;877.8507653698855;644.616453210339;644.8742495213435;653.921529416473;655.8262060553957;656.3469347998772;12988;12989.41547630359;13033;13072.542461013818;13670.863291367059;13329.400176992058;13472.663183420394;13653.590392288248;13682.726345473035;13742.862571374259;10938.890611093866;11167.944160279147;11365.431728413547;11504.94247528757;11562.248453850472;4279.272523670983;4321.741807960124;4394.252976993918;4501.594856462934;4548.863534093983;85846.57076714576;88603.67094493652;89085.55457222737;89998.95004724737;90871;10106.898931010743;10251.692449226535;10311.896881031094;10355.482225888676;10383.792324153626;18897.14962826676;18946.86318820875;18953.526161845788;18971.905140474486;19105.80894191068;7671.424643151786;7765.7670269892;7775.533467991939;7882.802929926797;7954.164812694699;4024.6981476389387;4133.379993001014;4166.687498437629;4231.174920890397;4330.718503297276;3415.0608582639475;3467.375872342952;3524.559430071241;3525.6121826599056;3529;614.0328981853598;619.510586636552;653.738504598155;659.7695298268694;668.1414382518441;574.4054903175194;631.1227393922452;646.6281887914467;650.2424675253277;665.4809248785955;9497.525123743924;9977.451240181714;9991;10185.592576297013;10291.845622315672;527.1591811061351;550.6613432738917;561.9466150715675;568.3378863623915;599.3167788720862;4177.394277829698;4530.864074077783;4545.136424079415;4608.212031720761;4627.629789616823;104886;108038;108194.45902770436;112021;116754;75303;91516;95660.52169739107;97812;98100;79337;81864.77202841963;85110.5744471286;86879;89399.65900511497;7535.660895259617;8198.467099638505;8527.573621319034;8578.227959483676;8766.430182038148;49222.261666075756;50412;50607;52402;55994.44005559892;58031.419685802604;63015.36984630095;71437.28562714515;76610.6169469149;78025.60987195028;10772.622958196425;12327.321997289877;12669.176503527242;12675.30285834288;12771.680707982376;13635.86364136346;13695.112385653629;13972.790408143683;13980.231087290296;14698.485553005594;10543.998320159573;13379.799303010657;13438.932805336302;13596;14079.577612671636;12813.359332033548;13007.284599346749;13641.931790340985;14040.227787471787;14067.155970641794;12303.75392492163;13405.195688258736;13538.729225415633;13849.861501384858;13881.097728647606;10268.794624107626;10376.896231037896;10798.622048228275;10847.186461015297;11158.330500170016;9769.267304952014;10604.469776511298;10990.340579565252;11100.666979990614;11109.777804443704 12:04:42 INFO - PROCESS | 2376 | __end_tp_report 12:04:42 INFO - PROCESS | 2376 | __start_cc_report 12:04:42 INFO - PROCESS | 2376 | _x_x_mozilla_cycle_collect,372 12:04:42 INFO - PROCESS | 2376 | __end_cc_report 12:04:42 INFO - PROCESS | 2376 | __startTimestamp1479153882862__endTimestamp 12:04:42 INFO - PROCESS | 2376 | 12:04:42 INFO - PROCESS | 2376 | ------- Summary: start ------- 12:04:42 INFO - PROCESS | 2376 | Number of tests: 6 12:04:42 INFO - PROCESS | 2376 | 12:04:42 INFO - PROCESS | 2376 | [#0] dojo.html Cycles:165 Average:5767.43 Median:6040.24 stddev:662.85 (11.0%) stddev-sans-first:637.02 12:04:42 INFO - PROCESS | 2376 | Values: 3343.2 3352.1 3383.2 3387.2 3406.3 5803.5 5879.9 5932.3 5970.4 5985.5 5967.0 5998.9 6015.4 6028.3 6033.5 5316.0 5387.0 5415.0 5443.9 5448.2 5337.6 5453.0 5456.9 5462.3 5469.6 5217.2 5261.7 5324.4 5366.5 5385.1 4506.3 5253.8 5315.1 5320.3 5322.5 5158.5 5182.7 5235.6 5244.6 5248.1 4944.9 5917.3 5952.3 5984.1 5985.9 6106.2 6149.3 6202.3 6222.8 6241.5 6237.5 6295.3 6296.4 6302.2 6309.6 5868.5 6040.2 6045.1 6045.5 6097.7 6177.6 6283.7 6310.8 6370.7 6378.7 6148.7 6165.3 6175.6 6184.2 6216.6 6265.4 6305.5 6328.3 6333.9 6335.7 6024.9 6035.0 6089.5 6106.9 6139.9 6120.9 6124.6 6129.9 6138.1 6141.3 4913.0 4971.0 4991.2 4991.8 4996.6 3717.9 4186.4 4482.3 4495.1 4496.2 4792.2 5232.2 5399.6 5635.2 5895.1 5220.0 5234.9 6187.8 6225.3 6247.1 5832.2 5965.6 5966.4 5988.3 6030.3 5498.1 5512.4 5547.8 5549.2 5552.3 6170.6 6226.8 6240.8 6273.9 6426.3 6233.8 6260.3 6275.6 6288.9 6299.9 6384.8 6395.6 6405.9 6409.9 6439.6 6137.5 6154.4 6157.6 6224.1 6264.4 6134.5 6140.7 6176.0 6212.0 6218.6 5147.3 5736.3 6147.4 6196.6 6231.3 6125.5 6162.3 6189.1 6190.5 6194.9 4805.9 5659.9 6011.8 6039.1 6077.1 6120.5 6144.3 6162.8 6166.4 6177.6 5974.0 6052.3 6079.0 6101.7 6131.0 12:04:42 INFO - PROCESS | 2376 | 12:04:42 INFO - PROCESS | 2376 | [#1] ext.html Cycles:180 Average:68112.77 Median:38371.12 stddev:154323.79 (402.2%) stddev-sans-first:154673.25 12:04:42 INFO - PROCESS | 2376 | Values: 512.3 513.9 521.4 526.0 548.3 29401.3 31230.9 31339.5 38381.6 39484.4 40829.2 41143.8 41185.8 41239.8 41498.6 8780.7 9236.4 9392.8 9421.7 9428.9 7596.9 8029.8 8150.0 9454.0 9468.4 9435.7 9438.2 9444.2 9466.8 9488.3 8551.4 9330.8 9375.7 9455.1 9474.0 8153.8 9265.2 9268.7 9330.9 9355.3 38754.6 38948.8 38994.0 39025.6 39137.0 2901.6 3333.7 3376.4 3452.0 3534.0 27947.3 28445.9 29462.9 29719.9 30198.8 3150.4 3151.9 3162.3 3175.9 3183.2 363610.0 366284.0 366517.0 366842.0 367649.0 48013.8 55117.2 56145.7 56178.7 56566.7 57049.0 57151.0 58307.1 58364.4 58592.0 14772.5 15782.4 15816.8 15838.7 15879.3 12256.9 12303.8 12308.8 12334.4 12345.8 14398.6 14930.6 15012.1 15054.9 15186.4 3141.5 5160.8 5688.9 5958.3 5962.4 827.5 978.3 1008.2 1009.4 1019.1 24948.4 29758.1 29924.7 29929.1 30164.4 946.7 1002.1 1010.5 1017.2 1105.9 14966.6 15225.6 15581.4 15608.6 15641.8 679695.0 687861.0 687875.0 687961.0 697843.0 55773.0 56227.0 56287.0 56502.7 56532.0 1349.1 1353.4 1374.9 1375.5 1384.3 28559.9 29079.9 29439.7 29609.0 30183.0 48078.3 48126.0 48218.0 48332.3 48395.3 615698.0 617131.0 619253.0 620666.0 622123.0 25685.5 26059.0 26106.7 26130.3 26183.1 44703.8 44960.3 45363.0 45804.5 46305.3 37887.0 38328.9 38360.6 38438.0 39213.0 29909.0 33119.5 34889.8 38882.2 39071.6 33052.3 35964.8 37409.8 38253.4 39904.0 31028.1 32025.7 33223.7 34221.8 34728.8 25417.6 25864.7 25970.7 25992.7 26151.8 12:04:42 INFO - PROCESS | 2376 | 12:04:42 INFO - PROCESS | 2376 | [#2] jquery.html Cycles:180 Average:29925.11 Median:381415.05 stddev:76680.97 (20.1%) stddev-sans-first:76863.94 12:04:42 INFO - PROCESS | 2376 | Values: 352.4 356.4 371.8 377.8 394.5 18069.5 18739.0 19469.3 19528.9 19710.1 18659.8 18798.0 19166.9 19287.9 19442.0 5719.9 5936.5 6001.9 6033.1 6034.3 5634.7 5913.6 5985.1 6015.8 6019.2 5505.2 5924.3 5970.6 5990.9 6000.8 5673.7 5809.5 5828.4 5840.6 5860.5 5547.3 5626.4 5643.4 5894.1 5950.5 12695.9 12768.8 12914.5 12944.5 23605.2 1815.4 2038.6 2179.1 2192.4 2256.7 8628.3 9601.3 9969.8 10012.2 10329.7 1634.7 1797.6 1856.9 1889.0 1916.2 120876.0 126251.0 127516.1 128164.9 131970.3 11337.1 11340.8 11760.6 11867.0 12040.9 14512.1 14537.7 14552.7 14576.9 14587.5 7221.7 8347.8 8458.2 8461.3 8588.0 8338.9 8341.9 8352.2 8402.7 8535.4 3824.4 4426.2 4429.7 4520.9 4556.0 1834.1 1919.0 1919.7 1924.0 1942.8 803.6 905.9 919.7 935.0 962.8 19871.4 20973.3 21140.0 21187.9 21253.7 865.5 909.2 921.4 935.8 967.0 5915.7 6083.3 6265.5 6288.2 10627.8 380330.0 380642.1 382188.0 465344.0 588146.0 104037.0 111984.0 120284.6 132547.0 134429.3 432.0 446.0 446.9 447.9 450.2 11093.4 11366.0 11425.7 11610.8 11730.6 53693.7 53745.2 54056.5 55171.7 56737.4 76026.6 78609.0 78788.0 80197.2 80521.6 7950.0 8119.8 8276.0 8321.0 8358.6 10810.6 12887.2 12907.0 13008.5 13185.8 5384.8 7632.8 8539.4 10945.0 11053.4 10252.4 10312.0 10571.4 10791.5 10947.2 10013.6 10618.4 11192.9 11201.2 11490.4 6882.0 7946.4 8117.9 8239.5 8272.0 10592.5 10814.9 10831.7 10984.9 11038.6 12:04:42 INFO - PROCESS | 2376 | 12:04:42 INFO - PROCESS | 2376 | [#3] mootools.html Cycles:180 Average:5341.70 Median:5185.06 stddev:2892.29 (55.8%) stddev-sans-first:2884.87 12:04:42 INFO - PROCESS | 2376 | Values: 1352.9 1496.0 1503.3 1798.6 1828.3 7576.6 7843.3 8095.2 8507.4 8553.2 8048.4 8344.5 8355.4 8461.8 8489.7 2345.0 2360.4 2366.5 2370.6 2382.6 2369.3 2386.4 2422.1 2422.3 2426.7 1995.9 2344.3 2368.8 2378.1 2380.2 2196.1 2221.9 2224.8 2237.0 2239.0 2263.8 2317.3 2320.3 2333.5 2339.7 8357.4 8394.7 8459.9 8471.4 8509.8 5044.0 5203.7 5210.9 5220.1 5230.0 3068.7 3300.3 3303.8 3306.9 3308.3 1049.2 1060.8 1082.9 1103.0 1104.8 9431.0 10853.6 10983.5 10996.6 11014.6 4434.6 4471.2 4531.2 4541.0 4739.6 9308.2 9394.2 9401.4 9414.3 9424.7 5156.4 5179.3 5180.2 5184.8 5185.3 4220.8 4237.0 4688.1 4732.4 4746.4 3803.0 3845.7 3902.3 3917.3 3947.9 1188.7 1237.3 1277.9 1291.6 1307.6 766.4 778.8 809.4 887.7 901.9 5446.9 5526.4 5642.2 5676.7 5712.0 454.5 454.5 456.1 945.5 973.6 3456.7 3739.9 3787.7 3802.2 3812.8 9167.9 9617.2 9812.8 9940.5 10204.0 7143.2 8172.8 8685.8 9034.8 9900.8 7642.9 7646.5 7838.2 7929.0 7941.5 4548.4 5054.3 5168.6 5503.1 5670.7 7502.6 8145.5 9431.3 9432.4 9442.3 7722.3 8166.4 9323.8 9506.2 9600.9 6601.2 6846.7 7004.4 7123.8 7282.4 7822.5 7846.8 7900.2 7909.0 7923.5 6959.6 7147.1 7155.9 7164.0 7207.9 6950.1 7032.9 7109.4 7117.9 7188.6 6621.6 6707.3 6738.9 6742.9 6745.7 4748.2 4830.3 4842.4 4847.5 4889.7 4776.2 4776.8 4915.9 4922.4 4949.9 12:04:42 INFO - PROCESS | 2376 | 12:04:42 INFO - PROCESS | 2376 | [#4] prototype.html Cycles:180 Average:4587.23 Median:5166.89 stddev:1430.25 (27.7%) stddev-sans-first:1397.65 12:04:42 INFO - PROCESS | 2376 | Values: 302.8 306.4 307.7 313.4 315.0 4690.8 4849.4 5407.8 5521.4 5663.9 4436.0 4800.6 4890.2 5314.7 5547.9 4176.0 4197.6 4201.2 4211.8 4226.4 3919.8 4140.8 4230.8 4233.7 4249.8 4137.8 4152.8 4159.9 4168.9 4172.2 3490.0 3494.9 3818.8 4169.4 4177.3 3599.4 3607.7 3617.2 3618.1 3624.2 5294.9 5311.6 5364.6 5380.3 5451.4 4596.2 4753.6 4821.7 4822.6 4843.9 5166.4 5170.8 5555.6 5827.5 5878.3 3147.8 3228.0 3363.4 3548.4 3978.8 5638.9 5692.5 5864.8 6112.0 6211.0 3606.7 3813.5 3980.0 4009.4 4063.6 3552.0 3945.8 4021.3 4068.2 4098.4 4393.8 4497.6 4525.8 4814.2 4831.2 5099.9 5477.2 5934.2 5966.4 6063.6 1208.5 1238.3 1250.7 1252.7 1297.6 805.9 809.0 815.5 828.2 891.8 4612.3 4666.6 4875.8 5353.3 5362.6 4872.5 5152.8 5342.7 5781.6 5807.4 4574.3 5200.9 5363.7 5376.0 5386.7 2678.7 2683.4 2821.6 3023.6 3055.4 5425.1 5703.2 5805.8 6009.5 6126.9 5082.2 5374.7 5512.0 5671.0 5734.7 5249.9 5418.1 5541.5 6051.7 6089.8 5449.6 5645.9 5657.0 5857.3 5861.0 4754.0 5356.4 5439.5 5678.6 5719.9 5125.5 5665.4 6019.5 6049.9 6073.7 3342.4 3689.0 3699.0 3854.8 3878.3 4991.0 5167.3 5463.6 5750.7 5800.5 5739.0 5740.9 5912.2 5925.5 5948.2 4976.9 5010.3 5753.1 5872.6 5901.9 4431.5 5728.9 5772.6 5791.7 5798.0 4771.7 5588.8 5850.2 5865.9 5913.2 5238.7 5364.8 5761.6 5797.0 5817.9 12:04:42 INFO - PROCESS | 2376 | 12:04:42 INFO - PROCESS | 2376 | [#5] yui.html Cycles:180 Average:20203.82 Median:4516.23 stddev:29544.04 (654.2%) stddev-sans-first:29590.54 12:04:42 INFO - PROCESS | 2376 | Values: 677.9 679.9 701.6 713.4 738.6 10690.0 13707.9 14676.8 14692.2 14763.5 12877.7 13167.2 13437.5 13616.7 13678.2 644.8 816.1 833.6 837.9 838.7 673.0 727.5 827.3 833.8 838.9 869.4 874.6 879.5 880.0 881.6 869.2 873.8 875.2 877.7 877.9 644.6 644.9 653.9 655.8 656.3 12988.0 12989.4 13033.0 13072.5 13670.9 13329.4 13472.7 13653.6 13682.7 13742.9 10938.9 11167.9 11365.4 11504.9 11562.2 4279.3 4321.7 4394.3 4501.6 4548.9 85846.6 88603.7 89085.6 89999.0 90871.0 10106.9 10251.7 10311.9 10355.5 10383.8 18897.1 18946.9 18953.5 18971.9 19105.8 7671.4 7765.8 7775.5 7882.8 7954.2 4024.7 4133.4 4166.7 4231.2 4330.7 3415.1 3467.4 3524.6 3525.6 3529.0 614.0 619.5 653.7 659.8 668.1 574.4 631.1 646.6 650.2 665.5 9497.5 9977.5 9991.0 10185.6 10291.8 527.2 550.7 561.9 568.3 599.3 4177.4 4530.9 4545.1 4608.2 4627.6 104886.0 108038.0 108194.5 112021.0 116754.0 75303.0 91516.0 95660.5 97812.0 98100.0 79337.0 81864.8 85110.6 86879.0 89399.7 7535.7 8198.5 8527.6 8578.2 8766.4 49222.3 50412.0 50607.0 52402.0 55994.4 58031.4 63015.4 71437.3 76610.6 78025.6 10772.6 12327.3 12669.2 12675.3 12771.7 13635.9 13695.1 13972.8 13980.2 14698.5 10544.0 13379.8 13438.9 13596.0 14079.6 12813.4 13007.3 13641.9 14040.2 14067.2 12303.8 13405.2 13538.7 13849.9 13881.1 10268.8 10376.9 10798.6 10847.2 11158.3 9769.3 10604.5 10990.3 11100.7 11109.8 12:04:42 INFO - PROCESS | 2376 | -------- Summary: end -------- 12:04:42 INFO - PROCESS | 2376 | 12:04:43 INFO - TEST-INFO | 2376: exit 0 12:04:43 INFO - TEST-OK | dromaeo_css | took 1116209ms 12:04:43 INFO - TEST-START | kraken 12:04:43 INFO - operating with platform_type : mac_ 12:04:43 INFO - Initialising browser for kraken test... 12:04:43 INFO - TEST-INFO | started process 2382 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpsYtx_a/profile http://localhost:51425/getInfo.html) 12:04:45 ERROR - PROCESS | 2382 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 12:04:46 INFO - PROCESS | 2382 | __metrics Screen width/height:1600/1200 12:04:46 INFO - PROCESS | 2382 | colorDepth:24 12:04:46 INFO - PROCESS | 2382 | Browser inner width/height: 1024/689 12:04:46 INFO - PROCESS | 2382 | __metrics 12:04:46 ERROR - PROCESS | 2382 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 12:04:47 INFO - TEST-INFO | 2382: exit 0 12:04:47 INFO - Browser initialized. 12:04:47 INFO - Running cycle 1/1 for kraken test... 12:04:47 INFO - TEST-INFO | started process 2384 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpsYtx_a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:04:59 INFO - PROCESS | 2384 | RSS: Main: 223973376 12:04:59 INFO - PROCESS | 2384 | 12:05:01 INFO - PROCESS | 2384 | Cycle 1(1): loaded http://localhost:51425/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51425/tests/kraken/driver.html?testName=audio-beat-detection) 12:05:02 INFO - PROCESS | 2384 | RSS: Main: 236507136 12:05:02 INFO - PROCESS | 2384 | 12:05:05 INFO - PROCESS | 2384 | Cycle 1(1): loaded http://localhost:51425/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51425/tests/kraken/driver.html?testName=audio-dft) 12:05:06 INFO - PROCESS | 2384 | RSS: Main: 244043776 12:05:06 INFO - PROCESS | 2384 | 12:05:09 INFO - PROCESS | 2384 | Cycle 1(1): loaded http://localhost:51425/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51425/tests/kraken/driver.html?testName=audio-fft) 12:05:10 INFO - PROCESS | 2384 | RSS: Main: 245846016 12:05:10 INFO - PROCESS | 2384 | 12:05:12 INFO - PROCESS | 2384 | Cycle 1(1): loaded http://localhost:51425/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51425/tests/kraken/driver.html?testName=audio-oscillator) 12:05:12 INFO - PROCESS | 2384 | RSS: Main: 247451648 12:05:12 INFO - PROCESS | 2384 | 12:05:14 INFO - PROCESS | 2384 | Cycle 1(1): loaded http://localhost:51425/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51425/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:05:15 INFO - PROCESS | 2384 | RSS: Main: 249143296 12:05:15 INFO - PROCESS | 2384 | 12:05:18 INFO - PROCESS | 2384 | Cycle 1(1): loaded http://localhost:51425/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51425/tests/kraken/driver.html?testName=imaging-darkroom) 12:05:18 INFO - PROCESS | 2384 | RSS: Main: 253190144 12:05:18 INFO - PROCESS | 2384 | 12:05:21 INFO - PROCESS | 2384 | Cycle 1(1): loaded http://localhost:51425/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51425/tests/kraken/driver.html?testName=imaging-desaturate) 12:05:22 INFO - PROCESS | 2384 | RSS: Main: 253399040 12:05:22 INFO - PROCESS | 2384 | 12:05:25 INFO - PROCESS | 2384 | Cycle 1(1): loaded http://localhost:51425/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51425/tests/kraken/driver.html?testName=json-parse-financial) 12:05:25 INFO - PROCESS | 2384 | RSS: Main: 252837888 12:05:25 INFO - PROCESS | 2384 | 12:05:27 INFO - PROCESS | 2384 | Cycle 1(1): loaded http://localhost:51425/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51425/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:05:28 INFO - PROCESS | 2384 | RSS: Main: 251891712 12:05:28 INFO - PROCESS | 2384 | 12:05:29 INFO - PROCESS | 2384 | Cycle 1(1): loaded http://localhost:51425/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51425/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:05:30 INFO - PROCESS | 2384 | RSS: Main: 252686336 12:05:30 INFO - PROCESS | 2384 | 12:05:32 INFO - PROCESS | 2384 | Cycle 1(1): loaded http://localhost:51425/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51425/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:05:33 INFO - PROCESS | 2384 | RSS: Main: 251969536 12:05:33 INFO - PROCESS | 2384 | 12:05:36 INFO - PROCESS | 2384 | Cycle 1(1): loaded http://localhost:51425/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51425/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:05:37 INFO - PROCESS | 2384 | RSS: Main: 251871232 12:05:37 INFO - PROCESS | 2384 | 12:05:40 INFO - PROCESS | 2384 | Cycle 1(1): loaded http://localhost:51425/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51425/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:05:41 INFO - PROCESS | 2384 | RSS: Main: 252203008 12:05:41 INFO - PROCESS | 2384 | 12:05:42 INFO - PROCESS | 2384 | Cycle 1(1): loaded http://localhost:51425/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51425/tests/kraken/driver.html?testName=ai-astar) 12:05:42 INFO - PROCESS | 2384 | RSS: Main: 254042112 12:05:42 INFO - PROCESS | 2384 | 12:05:42 INFO - PROCESS | 2384 | __start_tp_report 12:05:42 INFO - PROCESS | 2384 | _x_x_mozilla_page_load 12:05:42 INFO - PROCESS | 2384 | _x_x_mozilla_page_load_details 12:05:42 INFO - PROCESS | 2384 | |i|pagename|runs| 12:05:42 INFO - PROCESS | 2384 | |0;ai-astar;107;120;120;152;179;119;122;119;120;119 12:05:42 INFO - PROCESS | 2384 | |1;audio-beat-detection;176;140;120;150;116;114;114;127;133;97 12:05:42 INFO - PROCESS | 2384 | |2;audio-dft;209;193;258;194;192;267;280;213;195;197 12:05:42 INFO - PROCESS | 2384 | |3;audio-fft;85;57;59;83;60;59;60;60;95;62 12:05:42 INFO - PROCESS | 2384 | |4;audio-oscillator;76;61;89;82;99;102;110;74;70;89 12:05:42 INFO - PROCESS | 2384 | |5;imaging-gaussian-blur;89;86;89;87;90;85;103;86;87;85 12:05:42 INFO - PROCESS | 2384 | |6;imaging-darkroom;95;96;96;104;133;95;95;95;95;95 12:05:42 INFO - PROCESS | 2384 | |7;imaging-desaturate;89;93;85;93;91;90;89;93;88;95 12:05:42 INFO - PROCESS | 2384 | |8;json-parse-financial;56;55;56;57;60;61;59;61;59;60 12:05:42 INFO - PROCESS | 2384 | |9;json-stringify-tinderbox;68;75;74;86;76;69;71;71;71;72 12:05:42 INFO - PROCESS | 2384 | |10;stanford-crypto-aes;85;84;87;88;90;84;86;85;91;87 12:05:42 INFO - PROCESS | 2384 | |11;stanford-crypto-ccm;151;157;160;144;153;156;163;164;235;154 12:05:42 INFO - PROCESS | 2384 | |12;stanford-crypto-pbkdf2;199;227;224;170;226;226;204;171;171;170 12:05:42 INFO - PROCESS | 2384 | |13;stanford-crypto-sha256-iterative;67;64;69;67;68;66;67;68;66;66 12:05:42 INFO - PROCESS | 2384 | __end_tp_report 12:05:42 INFO - PROCESS | 2384 | __start_cc_report 12:05:43 INFO - PROCESS | 2384 | _x_x_mozilla_cycle_collect,978 12:05:43 INFO - PROCESS | 2384 | __end_cc_report 12:05:43 INFO - PROCESS | 2384 | __startTimestamp1479153942995__endTimestamp 12:05:43 INFO - PROCESS | 2384 | 12:05:43 INFO - PROCESS | 2384 | ------- Summary: start ------- 12:05:43 INFO - PROCESS | 2384 | Number of tests: 14 12:05:43 INFO - PROCESS | 2384 | 12:05:43 INFO - PROCESS | 2384 | [#0] ai-astar Cycles:10 Average:127.70 Median:120.00 stddev:21.31 (17.8%) stddev-sans-first:21.25 12:05:43 INFO - PROCESS | 2384 | Values: 107.0 120.0 120.0 152.0 179.0 119.0 122.0 119.0 120.0 119.0 12:05:43 INFO - PROCESS | 2384 | 12:05:43 INFO - PROCESS | 2384 | [#1] audio-beat-detection Cycles:10 Average:128.70 Median:136.50 stddev:22.40 (16.4%) stddev-sans-first:15.92 12:05:43 INFO - PROCESS | 2384 | Values: 176.0 140.0 120.0 150.0 116.0 114.0 114.0 127.0 133.0 97.0 12:05:43 INFO - PROCESS | 2384 | 12:05:43 INFO - PROCESS | 2384 | [#2] audio-dft Cycles:10 Average:219.80 Median:211.00 stddev:34.59 (16.4%) stddev-sans-first:36.46 12:05:43 INFO - PROCESS | 2384 | Values: 209.0 193.0 258.0 194.0 192.0 267.0 280.0 213.0 195.0 197.0 12:05:43 INFO - PROCESS | 2384 | 12:05:43 INFO - PROCESS | 2384 | [#3] audio-fft Cycles:10 Average:68.00 Median:61.00 stddev:13.96 (22.9%) stddev-sans-first:13.38 12:05:43 INFO - PROCESS | 2384 | Values: 85.0 57.0 59.0 83.0 60.0 59.0 60.0 60.0 95.0 62.0 12:05:43 INFO - PROCESS | 2384 | 12:05:43 INFO - PROCESS | 2384 | [#4] audio-oscillator Cycles:10 Average:85.20 Median:79.00 stddev:15.47 (19.6%) stddev-sans-first:16.05 12:05:43 INFO - PROCESS | 2384 | Values: 76.0 61.0 89.0 82.0 99.0 102.0 110.0 74.0 70.0 89.0 12:05:43 INFO - PROCESS | 2384 | 12:05:43 INFO - PROCESS | 2384 | [#5] imaging-gaussian-blur Cycles:10 Average:88.70 Median:87.00 stddev:5.31 (6.1%) stddev-sans-first:5.63 12:05:43 INFO - PROCESS | 2384 | Values: 89.0 86.0 89.0 87.0 90.0 85.0 103.0 86.0 87.0 85.0 12:05:43 INFO - PROCESS | 2384 | 12:05:43 INFO - PROCESS | 2384 | [#6] imaging-darkroom Cycles:10 Average:99.90 Median:95.00 stddev:11.96 (12.6%) stddev-sans-first:12.55 12:05:43 INFO - PROCESS | 2384 | Values: 95.0 96.0 96.0 104.0 133.0 95.0 95.0 95.0 95.0 95.0 12:05:43 INFO - PROCESS | 2384 | 12:05:43 INFO - PROCESS | 2384 | [#7] imaging-desaturate Cycles:10 Average:90.60 Median:92.00 stddev:2.99 (3.2%) stddev-sans-first:3.11 12:05:43 INFO - PROCESS | 2384 | Values: 89.0 93.0 85.0 93.0 91.0 90.0 89.0 93.0 88.0 95.0 12:05:43 INFO - PROCESS | 2384 | 12:05:43 INFO - PROCESS | 2384 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:59.50 stddev:2.22 (3.7%) stddev-sans-first:2.18 12:05:43 INFO - PROCESS | 2384 | Values: 56.0 55.0 56.0 57.0 60.0 61.0 59.0 61.0 59.0 60.0 12:05:43 INFO - PROCESS | 2384 | 12:05:43 INFO - PROCESS | 2384 | [#9] json-stringify-tinderbox Cycles:10 Average:73.30 Median:73.00 stddev:5.12 (7.0%) stddev-sans-first:5.06 12:05:43 INFO - PROCESS | 2384 | Values: 68.0 75.0 74.0 86.0 76.0 69.0 71.0 71.0 71.0 72.0 12:05:43 INFO - PROCESS | 2384 | 12:05:43 INFO - PROCESS | 2384 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:87.00 stddev:2.41 (2.8%) stddev-sans-first:2.47 12:05:43 INFO - PROCESS | 2384 | Values: 85.0 84.0 87.0 88.0 90.0 84.0 86.0 85.0 91.0 87.0 12:05:43 INFO - PROCESS | 2384 | 12:05:43 INFO - PROCESS | 2384 | [#11] stanford-crypto-ccm Cycles:10 Average:163.70 Median:158.50 stddev:25.73 (16.2%) stddev-sans-first:26.88 12:05:43 INFO - PROCESS | 2384 | Values: 151.0 157.0 160.0 144.0 153.0 156.0 163.0 164.0 235.0 154.0 12:05:43 INFO - PROCESS | 2384 | 12:05:43 INFO - PROCESS | 2384 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:198.80 Median:214.00 stddev:26.12 (12.2%) stddev-sans-first:27.71 12:05:43 INFO - PROCESS | 2384 | Values: 199.0 227.0 224.0 170.0 226.0 226.0 204.0 171.0 171.0 170.0 12:05:43 INFO - PROCESS | 2384 | 12:05:43 INFO - PROCESS | 2384 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.40 (2.1%) stddev-sans-first:1.48 12:05:43 INFO - PROCESS | 2384 | Values: 67.0 64.0 69.0 67.0 68.0 66.0 67.0 68.0 66.0 66.0 12:05:43 INFO - PROCESS | 2384 | -------- Summary: end -------- 12:05:43 INFO - PROCESS | 2384 | 12:05:43 INFO - TEST-INFO | 2384: exit 0 12:05:43 INFO - TEST-OK | kraken | took 60403ms 12:05:43 INFO - SUITE-END | took 1176s 12:05:44 INFO - Completed test suite (00:19:36) 12:05:44 INFO - javascript benchmark 12:05:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7044.512702617829, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3343.2310568569214, 3352.1116904020437, 3383.238771276463, 3387.1701433148883, 3406.2846802171543, 5803.506701930336, 5879.853003674915, 5932.288125424944, 5970.373110823366, 5985.4912332451795, 5967.0, 5998.940010599893, 6015.398460153982, 6028.336882942884, 6033.48715359195, 5315.973420132894, 5386.974777403888, 5415.0, 5443.945560544404, 5448.182772584124, 5337.599680023995, 5453.0, 5456.945430545684, 5462.262594549745, 5469.617126801126, 5217.165253559412, 5261.736913154327, 5324.41431442541, 5366.543843773284, 5385.118961355695, 4506.346579745951, 5253.816116435944, 5315.123004704219, 5320.334958130234, 5322.547583455373, 5158.509941555584, 5182.663126896739, 5235.55497782689, 5244.554212891909, 5248.107821670325, 4944.851654450372, 5917.260342457193, 5952.345242023374, 5984.102384642339, 5985.910211346833, 6106.236720409949, 6149.292831324366, 6202.348753380875, 6222.751089956397, 6241.531885108589, 6237.532185086091, 6295.276043254993, 6296.433321001086, 6302.243730752339, 6309.558330916838, 5868.530517558671, 6040.244969378871, 6045.1234570987845, 6045.486133678643, 6097.725602347817, 6177.567570270128, 6283.717232724538, 6310.842228944313, 6370.713317900706, 6378.712957916905, 6148.739508400767, 6165.290991536031, 6175.62946223219, 6184.165137706352, 6216.627002379872, 6265.404786545271, 6305.464035557029, 6328.335524769925, 6333.936660633335, 6335.714892829834, 6024.879502409927, 6035.0, 6089.482393996472, 6106.938930610726, 6139.907901381483, 6120.938790612126, 6124.5712800103565, 6129.877402451926, 6138.1099740537375, 6141.30190404341, 4912.9508704913205, 4971.030649023478, 4991.176455884738, 4991.775370108354, 4996.575291100225, 3717.9256414872093, 4186.434831297735, 4482.327650852399, 4495.123450927038, 4496.213162696515, 4792.185328494164, 5232.2413250078525, 5399.622026458111, 5635.154726790932, 5895.145203945404, 5220.034293655686, 5234.947650523446, 6187.752489900354, 6225.28409232935, 6247.125402443661, 5832.1834943108, 5965.582409231399, 5966.433188847052, 5988.341282458926, 6030.276366836008, 5498.147787093007, 5512.4211957744665, 5547.77808887648, 5549.223108764776, 5552.305961754781, 6170.598911070766, 6226.782062627786, 6240.843978900564, 6273.874522509615, 6426.2931077581425, 6233.781817636361, 6260.311365749855, 6275.623462592259, 6288.905666415099, 6299.937000629935, 6384.840378990562, 6395.616263024233, 6405.903911441425, 6409.903851442139, 6439.613623182624, 6137.508999280136, 6154.446099851035, 6157.630542167305, 6224.097505861715, 6264.404881536247, 6134.478569321657, 6140.749659041455, 6175.96912015437, 6212.0371342441995, 6218.626882387071, 5147.279380886754, 5736.340320863154, 6147.385261473817, 6196.597221180609, 6231.3145553988115, 6125.509959203164, 6162.26052873658, 6189.133521307111, 6190.50475961913, 6194.938050619436, 4805.903881922272, 5659.886802264014, 6011.849703757441, 6039.063945088518, 6077.118817771487, 6120.508083830795, 6144.262688477233, 6162.784302549389, 6166.352532983972, 6177.567570270038, 5974.0, 6052.303985041776, 6079.0, 6101.6644084574, 6131.0], "value": 5725.544215063603, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [512.3109417833015, 513.8895137545427, 521.3821621378667, 525.9684418934863, 548.3146067415732, 29401.264968375803, 31230.906918257864, 31339.529907051412, 38381.61618383815, 39484.40773388394, 40829.18341633165, 41143.79428102855, 41185.794071029675, 41239.79380103095, 41498.585014149925, 8780.736577902673, 9236.44581325121, 9392.7651808705, 9421.670241541548, 9428.905710942905, 7596.9240307596765, 8029.759107226792, 8150.0, 9454.0, 9468.40200723724, 9435.669751558697, 9438.244940404786, 9444.150026497648, 9466.763330916714, 9488.335816492849, 8551.444156129832, 9330.813383732288, 9375.6718514852, 9455.054494550524, 9473.952630236874, 8153.836923261501, 9265.212456941168, 9268.72193834186, 9330.860037099448, 9355.298352623513, 38754.61245387538, 38948.80525597354, 38994.0, 39025.60974390248, 39137.02157446058, 2901.5502597097275, 3333.7166340861054, 3376.40912840252, 3451.9654803451895, 3533.9928120485797, 27947.301317467023, 28445.85777071122, 29462.85268573665, 29719.851400743075, 30198.84900575505, 3150.385674793416, 3151.921201969946, 3162.256869635634, 3175.857086431093, 3183.2360233544014, 363610.0, 366284.0, 366517.0, 366842.0, 367649.0, 48013.75993120082, 55117.1732424014, 56145.71927140338, 56178.71910640502, 56566.717166414724, 57049.0, 57151.0, 58307.12539311914, 58364.41635583675, 58592.0, 14772.48296309624, 15782.36870525189, 15816.76274855878, 15838.683226335408, 15879.28543215558, 12256.938715306545, 12303.815442768366, 12308.81536776949, 12334.383280835922, 12345.753084938251, 14398.568042958728, 14930.626734331512, 15012.099274043592, 15054.924725376302, 15186.392544298104, 3141.5287706844156, 5160.767765450564, 5688.857778555486, 5958.285005799332, 5962.433568810956, 827.4993628854577, 978.2907392140642, 1008.2452274246634, 1009.3893194617298, 1019.0930072235716, 24948.37629059288, 29758.107256782332, 29924.700752992627, 29929.102126936228, 30164.396712066075, 946.7491114854569, 1002.0981116994762, 1010.5301035018751, 1017.2269075502523, 1105.911527077848, 14966.551003469913, 15225.619359515878, 15581.376744930303, 15608.609784755245, 15641.765373519407, 679695.0, 687861.0, 687875.0, 687961.0, 697843.0, 55773.0, 56227.0, 56287.02995395223, 56502.71748641231, 56532.0, 1349.1095876721513, 1353.4180302469836, 1374.9450021999207, 1375.5116933488669, 1384.335518950909, 28559.85760569554, 29079.85460072686, 29439.675214614967, 29609.0, 30183.0, 48078.27882581834, 48126.03747925092, 48218.03563928632, 48332.27501587409, 48395.27407088967, 615698.0, 617131.0, 619253.0, 620666.0, 622123.0, 25685.486290273715, 26059.0, 26106.73893261043, 26130.346741331618, 26183.083592074185, 44703.776481117384, 44960.32559511544, 45363.0, 45804.541954580025, 46305.3054204194, 37887.0, 38328.85013449601, 38360.61639383682, 38438.0, 39213.0, 29909.0, 33119.50320745239, 34889.82555087208, 38882.22235555216, 39071.63249286261, 33052.33895322032, 35964.82017589895, 37409.81295093507, 38253.42619860649, 39904.00239994023, 31028.0691579253, 32025.67974320227, 33223.6710531576, 34221.82889085539, 34728.78449254365, 25417.61873571861, 25864.741352586232, 25970.740292597588, 25992.740072599034, 26151.823167957107], "value": 18942.35015943187, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.4026774617025, 356.39946689827656, 371.8419671639553, 377.76012232232534, 394.498986287415, 18069.548261293476, 18739.0, 19469.3185738499, 19528.902355488237, 19710.113044912978, 18659.813401865977, 18798.0, 19166.904165479187, 19287.903560482177, 19442.0, 5719.885602287952, 5936.495397891184, 6001.909971350433, 6033.09503574463, 6034.306054803688, 5634.7182640867795, 5913.556483263773, 5985.102234664813, 6015.849603759897, 6019.247594050744, 5505.174223866432, 5924.348321684612, 5970.552208584352, 5990.9101363479585, 6000.75996960121, 5673.716314184295, 5809.506191973687, 5828.35888052316, 5840.591158618899, 5860.501857342131, 5547.278853748987, 5626.409227031185, 5643.435656434323, 5894.086416605433, 5950.4644581987395, 12695.873041269653, 12768.80846787299, 12914.54799082037, 12944.482220711161, 23605.173818916257, 1815.4372144635206, 2038.6126635939124, 2179.1283486605325, 2192.408049826538, 2256.7291924968945, 8628.266597339234, 9601.327907046509, 9969.750756231153, 10012.199024078056, 10329.690109296658, 1634.6730653869154, 1797.5506123469133, 1856.8700190986635, 1888.9622207555772, 1916.2430839818333, 120876.0, 126251.0, 127516.0872586912, 128164.87340506368, 131970.34014829865, 11337.145370574044, 11340.773184536263, 11760.58837940668, 11867.0, 12040.879591203975, 14512.1292722437, 14537.709245815024, 14552.708945821025, 14576.854231457763, 14587.489437869624, 7221.6750246238, 8347.83304333922, 8458.238758511763, 8461.280791132822, 8588.0, 8338.916610833936, 8341.874871876928, 8352.16478352172, 8402.663893444194, 8535.402521823413, 3824.4454554089502, 4426.247537918562, 4429.689921705514, 4520.932186017212, 4556.0, 1834.132763376986, 1918.9712154317697, 1919.673655478572, 1923.9519012024812, 1942.77658069321, 803.5941849366033, 905.8777065096259, 919.737874705719, 935.0, 962.831504486712, 19871.40385788429, 20973.265935692176, 21140.0, 21187.9406029701, 21253.68119478209, 865.5326123893027, 909.1726528858707, 921.447131720962, 935.8455854783884, 966.9758256043655, 5915.674637894871, 6083.300420451616, 6265.498760099181, 6288.245410550763, 10627.787444251071, 380330.0, 380642.0967895143, 382188.0, 465344.0, 588146.0, 104037.0, 111984.0, 120284.59430811334, 132547.0, 134429.32785336208, 431.95896389842915, 445.9564618792042, 446.91508613363357, 447.87011766587324, 450.2480856968804, 11093.44532773342, 11365.977062064454, 11425.714357141138, 11610.767784644091, 11730.589429369931, 53693.65765855885, 53745.19382209348, 54056.459435405144, 55171.72414137904, 56737.43262567487, 76026.61986690252, 78609.0, 78788.0, 80197.19802801897, 80521.59739201267, 7949.960250198712, 8119.83760324802, 8275.95862020686, 8321.0, 8358.582070896553, 10810.56757729682, 12887.226766394046, 12906.967442604757, 13008.544700935421, 13185.802212967004, 5384.784608615611, 7632.809179770328, 8539.359548034046, 10945.0, 11053.447327633747, 10252.38485690861, 10312.0, 10571.36571805694, 10791.460426978776, 10947.178961577754, 10013.648157498936, 10618.415987120474, 11192.888071119185, 11201.21591488588, 11490.425478726198, 6882.0, 7946.40401969843, 8117.863499110012, 8239.464434811718, 8272.0, 10592.523336449724, 10814.945925270324, 10831.708031225915, 10984.945075274572, 11038.558457661604], "value": 8747.138172791474, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1352.9255890926, 1495.9925200374, 1503.2784263553494, 1798.5863251452158, 1828.259554880274, 7576.621168941559, 7843.294103530696, 8095.150009249032, 8507.404481686284, 8553.187447192515, 8048.436609437342, 8344.45761025533, 8355.415120941536, 8461.830763384729, 8489.745307640766, 2344.9648255276184, 2360.44529535559, 2366.526694661066, 2370.596998510249, 2382.642603609455, 2369.2892132360307, 2386.3914701751114, 2422.1159276863996, 2422.2612103308484, 2426.745191754867, 1995.8503112266565, 2344.284993077111, 2368.7749663781915, 2378.0963233971065, 2380.1907351500486, 2196.1105752170397, 2221.922232721855, 2224.7552769195377, 2237.038073628339, 2239.014833473283, 2263.841531092824, 2317.304808557426, 2320.303908827345, 2333.5449587330477, 2339.7426283108844, 8357.414980951336, 8394.706185283547, 8459.857919180893, 8471.364647651451, 8509.829803403898, 5043.9747801260755, 5203.713795741232, 5210.921836172461, 5220.112580861225, 5230.0, 3068.6624471308137, 3300.2574420755377, 3303.8348082595776, 3306.8842590509216, 3308.2721801203697, 1049.1763965287214, 1060.7719340341864, 1082.8754693210303, 1103.0238239158323, 1104.8011357955565, 9431.0, 10853.565857365697, 10983.505742241618, 10996.560137594486, 11014.559417623286, 4434.600885920283, 4471.1728330259, 4531.161735078955, 4540.954590454053, 4739.573438390561, 9308.162265396011, 9394.201492873046, 9401.435913845191, 9414.340996130342, 9424.717258482257, 5156.4070131935305, 5179.274901513716, 5180.248863914711, 5184.792608295701, 5185.325907631984, 4220.767857767853, 4237.046664500463, 4688.062387522509, 4732.361131247238, 4746.38297021385, 3802.961970380316, 3845.673117784964, 3902.3366027774778, 3917.3144699678014, 3947.8618248361167, 1188.6968822950093, 1237.2761934268374, 1277.8786015328528, 1291.593148158327, 1307.6462367738034, 766.4328396986301, 778.8442311537715, 809.4212637963884, 887.729242581019, 901.8557030875029, 5446.91829622556, 5526.4197259288, 5642.238297829823, 5676.744546495418, 5712.0, 454.470541818784, 454.4887002122612, 456.07644519847577, 945.4610871803144, 973.5813600151861, 3456.701293639752, 3739.9439008414897, 3787.659110679997, 3802.2205447883116, 3812.7712337259854, 9167.899852017801, 9617.23062155026, 9812.803743925082, 9940.45327506994, 10204.0, 7143.214246432888, 8172.754817355489, 8685.827413299125, 9034.819303614022, 9900.80198396028, 7642.885356719654, 7646.464747467735, 7838.21617838223, 7929.048514178336, 7941.523508589503, 4548.408706868086, 5054.29239906406, 5168.604476791321, 5503.147012213113, 5670.659760414388, 7502.624868756649, 8145.51126932386, 9431.339806213773, 9432.434053956784, 9442.339036267394, 7722.266384693445, 8166.387520936072, 9323.813523729352, 9506.239500840054, 9600.85598716006, 6601.207855057424, 6846.657667116724, 7004.3696067354185, 7123.7506687265695, 7282.417406607353, 7822.4524283299625, 7846.843063138819, 7900.170482099296, 7909.0, 7923.524588524707, 6959.617221052688, 7147.106611673541, 7155.928440715526, 7164.032855564432, 7207.855842883008, 6950.131233595801, 7032.929670703227, 7109.360157585842, 7117.8932316016335, 7188.568685878864, 6621.569597976309, 6707.262201157966, 6738.898916516158, 6742.898856517058, 6745.696443660146, 4748.192807222711, 4830.2513110467935, 4842.443119041214, 4847.5394837490385, 4889.682170658896, 4776.164171269945, 4776.761161941959, 4915.852524424273, 4922.4339200992345, 4949.901001980013], "value": 4321.6913360260205, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.8334416071162, 306.37040880989565, 307.67079225228986, 313.44520199247324, 314.9889753858615, 4690.765461726917, 4849.41806983162, 5407.755781350735, 5521.365043020049, 5663.886722265557, 4435.9556404436025, 4800.5679488846, 4890.193118135503, 5314.681119132854, 5547.944520554794, 4176.0, 4197.559256278085, 4201.159768046387, 4211.831526738927, 4226.400763530437, 3919.823607937635, 4140.772257525835, 4230.830766769341, 4233.74597524148, 4249.767567405449, 4137.813798379065, 4152.792360381984, 4159.916801663965, 4168.937465938014, 4172.16556688662, 3489.9825500872334, 3494.860205591773, 3818.8472461101524, 4169.3954376615375, 4177.26897792885, 3599.4420864766003, 3607.6933460655614, 3617.186133120027, 3618.1316484043905, 3624.2422425123796, 5294.947050529484, 5311.601629877775, 5364.624476286662, 5380.273663055476, 5451.373092094381, 4596.241620132674, 4753.572178503951, 4821.734804585746, 4822.590079843218, 4843.854684359475, 5166.43169251382, 5170.844874653766, 5555.611107222496, 5827.532618092228, 5878.265216847894, 3147.8268695221755, 3228.0315905228335, 3363.360961417323, 3548.432250839853, 3978.840846366171, 5638.9004144191895, 5692.48767610917, 5864.76540938362, 6112.0, 6211.0, 3606.747527673038, 3813.466114743938, 3980.0447892506168, 4009.4386785850006, 4063.5733248008532, 3552.0, 3945.7706395886235, 4021.276170289376, 4068.1863627274665, 4098.385242213632, 4393.846215382447, 4497.572730590588, 4525.800662824354, 4814.181589129857, 4831.178699621073, 5099.87250318745, 5477.20580515823, 5934.1692163097205, 5966.373530779292, 6063.605865618721, 1208.5407545132969, 1238.3065483329365, 1250.662321173278, 1252.6596541700294, 1297.6107167849607, 805.9200671100754, 808.975730728079, 815.4984684419039, 828.1676914700687, 891.791622351717, 4612.303804801068, 4666.5533684557895, 4875.780589873464, 5353.250544923714, 5362.597805164628, 4872.4640289568115, 5152.845414637567, 5342.732863356817, 5781.566382521328, 5807.419258074159, 4574.30116231425, 5200.869978250574, 5363.678179309254, 5375.951689420525, 5386.676799392049, 2678.7321267873444, 2683.3828219509232, 2821.6190814239817, 3023.6069310989433, 3055.4194703006356, 5425.074098694985, 5703.178870157005, 5805.82582522525, 6009.45914867664, 6126.927787637145, 5082.204787367007, 5374.650647707965, 5512.0, 5670.971645141748, 5734.713264336767, 5249.868753281198, 5418.051840927901, 5541.473560011793, 6051.727672254759, 6089.817305480754, 5449.64577302474, 5645.943540564706, 5656.971715141398, 5857.326407463196, 5861.007257532459, 4754.049190162051, 5356.393082075284, 5439.504136362374, 5678.630888992202, 5719.885602287848, 5125.487451254994, 5665.405132461032, 6019.4883434908525, 6049.879002419839, 6073.722354117206, 3342.431786596333, 3689.0448062526903, 3699.0, 3854.768713877176, 3878.301905657009, 4990.9750451248965, 5167.34644913624, 5463.644863083887, 5750.741216645345, 5800.477956983892, 5738.971305143615, 5740.885182296414, 5912.172295878494, 5925.496332811759, 5948.226730525177, 4976.925346119739, 5010.273510340907, 5753.108268218432, 5872.647641141545, 5901.93432298692, 4431.4903786065015, 5728.942710572841, 5772.624779389326, 5791.681457519709, 5797.971010144923, 4771.73755443454, 5588.792426991397, 5850.2102216200265, 5865.856158049311, 5913.172155898264, 5238.738063096906, 5364.758585863724, 5761.596688231783, 5796.971015145066, 5817.894600025981], "value": 4121.6192127050535, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [677.8745932002577, 679.9252082270951, 701.642162497127, 713.4078714666826, 738.6417587470077, 10689.984451477107, 13707.862921370795, 14676.779848302258, 14692.191929443903, 14763.483278085268, 12877.678058048554, 13167.209967401963, 13437.462501499953, 13616.659583510418, 13678.247696376695, 644.7904431059901, 816.1185919207242, 833.5748768128237, 837.8952630921135, 838.7316058861167, 672.9831754206159, 727.5343779980816, 827.3174630929477, 833.8082241084554, 838.9203025712548, 869.430523007428, 874.623911717961, 879.4855009819263, 879.9648014079429, 881.5548148185158, 869.1829680100685, 873.7597160780773, 875.2210532625968, 877.7015814623027, 877.8507653698855, 644.616453210339, 644.8742495213435, 653.921529416473, 655.8262060553957, 656.3469347998772, 12988.0, 12989.41547630359, 13033.0, 13072.542461013818, 13670.863291367059, 13329.400176992058, 13472.663183420394, 13653.590392288248, 13682.726345473035, 13742.862571374259, 10938.890611093866, 11167.944160279147, 11365.431728413547, 11504.94247528757, 11562.248453850472, 4279.272523670983, 4321.741807960124, 4394.252976993918, 4501.594856462934, 4548.863534093983, 85846.57076714576, 88603.67094493652, 89085.55457222737, 89998.95004724737, 90871.0, 10106.898931010743, 10251.692449226535, 10311.896881031094, 10355.482225888676, 10383.792324153626, 18897.14962826676, 18946.86318820875, 18953.526161845788, 18971.905140474486, 19105.80894191068, 7671.424643151786, 7765.7670269892, 7775.533467991939, 7882.802929926797, 7954.164812694699, 4024.6981476389387, 4133.379993001014, 4166.687498437629, 4231.174920890397, 4330.718503297276, 3415.0608582639475, 3467.375872342952, 3524.559430071241, 3525.6121826599056, 3529.0, 614.0328981853598, 619.510586636552, 653.738504598155, 659.7695298268694, 668.1414382518441, 574.4054903175194, 631.1227393922452, 646.6281887914467, 650.2424675253277, 665.4809248785955, 9497.525123743924, 9977.451240181714, 9991.0, 10185.592576297013, 10291.845622315672, 527.1591811061351, 550.6613432738917, 561.9466150715675, 568.3378863623915, 599.3167788720862, 4177.394277829698, 4530.864074077783, 4545.136424079415, 4608.212031720761, 4627.629789616823, 104886.0, 108038.0, 108194.45902770436, 112021.0, 116754.0, 75303.0, 91516.0, 95660.52169739107, 97812.0, 98100.0, 79337.0, 81864.77202841963, 85110.5744471286, 86879.0, 89399.65900511497, 7535.660895259617, 8198.467099638505, 8527.573621319034, 8578.227959483676, 8766.430182038148, 49222.261666075756, 50412.0, 50607.0, 52402.0, 55994.44005559892, 58031.419685802604, 63015.36984630095, 71437.28562714515, 76610.6169469149, 78025.60987195028, 10772.622958196425, 12327.321997289877, 12669.176503527242, 12675.30285834288, 12771.680707982376, 13635.86364136346, 13695.112385653629, 13972.790408143683, 13980.231087290296, 14698.485553005594, 10543.998320159573, 13379.799303010657, 13438.932805336302, 13596.0, 14079.577612671636, 12813.359332033548, 13007.284599346749, 13641.931790340985, 14040.227787471787, 14067.155970641794, 12303.75392492163, 13405.195688258736, 13538.729225415633, 13849.861501384858, 13881.097728647606, 10268.794624107626, 10376.896231037896, 10798.622048228275, 10847.186461015297, 11158.330500170016, 9769.267304952014, 10604.469776511298, 10990.340579565252, 11100.666979990614, 11109.777804443704], "value": 7231.411460570964, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1556.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 120.0, 120.0, 152.0, 179.0, 119.0, 122.0, 119.0, 120.0, 119.0], "value": 127.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 140.0, 120.0, 150.0, 116.0, 114.0, 114.0, 127.0, 133.0, 97.0], "value": 128.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [209.0, 193.0, 258.0, 194.0, 192.0, 267.0, 280.0, 213.0, 195.0, 197.0], "value": 219.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 57.0, 59.0, 83.0, 60.0, 59.0, 60.0, 60.0, 95.0, 62.0], "value": 68.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 61.0, 89.0, 82.0, 99.0, 102.0, 110.0, 74.0, 70.0, 89.0], "value": 85.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 87.0, 90.0, 85.0, 103.0, 86.0, 87.0, 85.0], "value": 88.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 104.0, 133.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 99.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 93.0, 85.0, 93.0, 91.0, 90.0, 89.0, 93.0, 88.0, 95.0], "value": 90.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 56.0, 57.0, 60.0, 61.0, 59.0, 61.0, 59.0, 60.0], "value": 58.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 75.0, 74.0, 86.0, 76.0, 69.0, 71.0, 71.0, 71.0, 72.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 87.0, 88.0, 90.0, 84.0, 86.0, 85.0, 91.0, 87.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 157.0, 160.0, 144.0, 153.0, 156.0, 163.0, 164.0, 235.0, 154.0], "value": 163.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 227.0, 224.0, 170.0, 226.0, 226.0, 204.0, 171.0, 171.0, 170.0], "value": 198.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 69.0, 67.0, 68.0, 66.0, 67.0, 68.0, 66.0, 66.0], "value": 66.8, "unit": "score"}]}]} 12:05:44 INFO - Return code: 0 12:05:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:05:44 ERROR - # TBPL SUCCESS # 12:05:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:05:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:05:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:05:44 INFO - 2016-11-14 12:05:44.306 screenresolution[2389:20865] starting screenresolution argv=screenresolution get 12:05:44 INFO - 2016-11-14 12:05:44.309 screenresolution[2389:20865] Display 0: 1600x1200x32@60 12:05:44 INFO - 2016-11-14 12:05:44.315 screenresolution[2390:20868] starting screenresolution argv=screenresolution list 12:05:44 INFO - Available Modes on Display 0 12:05:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:05:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:05:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:05:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:05:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:05:44 INFO - Intel Iris: 12:05:44 INFO - Chipset Model: Intel Iris 12:05:44 INFO - Type: GPU 12:05:44 INFO - Bus: Built-In 12:05:44 INFO - VRAM (Dynamic, Max): 1536 MB 12:05:44 INFO - Vendor: Intel (0x8086) 12:05:44 INFO - Device ID: 0x0a2e 12:05:44 INFO - Revision ID: 0x0009 12:05:44 INFO - Displays: 12:05:44 INFO - Display: 12:05:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:05:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:05:44 INFO - Display Serial Number: 1600x1200 60 12:05:44 INFO - Main Display: Yes 12:05:44 INFO - Mirror: Off 12:05:44 INFO - Online: Yes 12:05:44 INFO - Rotation: Supported 12:05:44 INFO - Return code: 0 12:05:44 INFO - Running post-action listener: _resource_record_post_action 12:05:44 INFO - [mozharness: 2016-11-14 20:05:44.548670Z] Finished run-tests step (success) 12:05:44 INFO - Running post-run listener: _resource_record_post_run 12:05:44 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 299008; Write bytes: 655474688; Read time: 6; Write time: 2022 12:05:44 INFO - TinderboxPrint: CPU usage
54.8% 12:05:44 INFO - TinderboxPrint: I/O read bytes / time
299,008 / 6 12:05:44 INFO - TinderboxPrint: I/O write bytes / time
655,474,688 / 2,022 12:05:44 INFO - TinderboxPrint: CPU idle
2,188.8 (45.2%) 12:05:44 INFO - TinderboxPrint: CPU system
987.0 (20.4%) 12:05:44 INFO - TinderboxPrint: CPU user
1,661.9 (34.4%) 12:05:44 INFO - TinderboxPrint: Swap in / out
353,406,976 / 0 12:05:44 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 353956352; Write bytes: 355943936; Read time: 27538; Write time: 728 12:05:44 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 204800; Write bytes: 298248704; Read time: 5; Write time: 1287 12:05:45 INFO - Running post-run listener: _upload_blobber_files 12:05:45 INFO - Blob upload gear active. 12:05:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:05:45 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 12:05:45 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:05:45 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:05:45 INFO - (blobuploader) - INFO - Open directory for files ... 12:05:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:05:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:05:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:05:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:05:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:05:46 INFO - (blobuploader) - INFO - Done attempting. 12:05:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:05:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:05:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:05:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:05:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:05:47 INFO - (blobuploader) - INFO - Done attempting. 12:05:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:05:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:05:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:05:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:05:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:05:49 INFO - (blobuploader) - INFO - Done attempting. 12:05:49 INFO - (blobuploader) - INFO - Iteration through files over. 12:05:49 INFO - Return code: 0 12:05:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:05:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:05:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1dca2a55012f1e29927e561bf9d8554cba3fef674ac780a7fcbc7665e1b0e239ed403cea5594020c9fda48d8c19453daabc7ce27f45b47de3baa51842ffd8930", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/caee2b8ba879a5b1910f6a6a91cdf9b5bba8cfed69b4dec72439a269680c6d36fdb3b065bda02755984ccf468516db050f7682d6299eaf7656232b2f2d26398e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7102923dfc46410d8070cb74288ac63fe964463036907b5f7cb9ed2e1d49dec797b3c997fce7533ebfd47116614a09db48c5faad0810eceaa84fb0d734c87f75"} 12:05:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:05:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:05:49 INFO - Contents: 12:05:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1dca2a55012f1e29927e561bf9d8554cba3fef674ac780a7fcbc7665e1b0e239ed403cea5594020c9fda48d8c19453daabc7ce27f45b47de3baa51842ffd8930", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/caee2b8ba879a5b1910f6a6a91cdf9b5bba8cfed69b4dec72439a269680c6d36fdb3b065bda02755984ccf468516db050f7682d6299eaf7656232b2f2d26398e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7102923dfc46410d8070cb74288ac63fe964463036907b5f7cb9ed2e1d49dec797b3c997fce7533ebfd47116614a09db48c5faad0810eceaa84fb0d734c87f75"} 12:05:49 INFO - Running post-run listener: copy_logs_to_upload_dir 12:05:49 INFO - Copying logs to upload dir... 12:05:49 INFO - mkdir: /builds/slave/test/build/upload/logs 12:05:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.362694 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-14 12:05:49.833077) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 12:05:49.840573) ========= 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.bxx9OlTUmC/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.GBQEtZ4NEM/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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-Aurora/sha512/1dca2a55012f1e29927e561bf9d8554cba3fef674ac780a7fcbc7665e1b0e239ed403cea5594020c9fda48d8c19453daabc7ce27f45b47de3baa51842ffd8930", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/caee2b8ba879a5b1910f6a6a91cdf9b5bba8cfed69b4dec72439a269680c6d36fdb3b065bda02755984ccf468516db050f7682d6299eaf7656232b2f2d26398e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7102923dfc46410d8070cb74288ac63fe964463036907b5f7cb9ed2e1d49dec797b3c997fce7533ebfd47116614a09db48c5faad0810eceaa84fb0d734c87f75"} build_url:https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011269 build_url: 'https://queue.taskcluster.net/v1/task/eZyhYxOYSvy1ST5dDi66KQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1dca2a55012f1e29927e561bf9d8554cba3fef674ac780a7fcbc7665e1b0e239ed403cea5594020c9fda48d8c19453daabc7ce27f45b47de3baa51842ffd8930", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/caee2b8ba879a5b1910f6a6a91cdf9b5bba8cfed69b4dec72439a269680c6d36fdb3b065bda02755984ccf468516db050f7682d6299eaf7656232b2f2d26398e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7102923dfc46410d8070cb74288ac63fe964463036907b5f7cb9ed2e1d49dec797b3c997fce7533ebfd47116614a09db48c5faad0810eceaa84fb0d734c87f75"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 12:05:49.876328) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:05:49.876669) ========= 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.bxx9OlTUmC/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.GBQEtZ4NEM/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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.005463 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:05:49.924918) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 12:05:49.928250) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 12:05:49.928567) ========= ========= Total master_lag: 0.20 =========