builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0122 starttime: 1467070742.16 results: success (0) buildid: 20160627144420 builduid: 4360f4d245a549be90444bafc60905d0 revision: 676a32cdd41fd372f4c6df3a4954939f73a6ef02 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 16:39:02.157206) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 16:39:02.157733) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 16:39:02.158049) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 16:39:02.201741) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 16:39:02.202008) ========= 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.iAvAx5pGWE/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.r78gllWsxb/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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-06-27 16:39:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.2M=0.001s 2016-06-27 16:39:02 (15.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.502517 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 16:39:02.730841) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 16:39:02.731797) ========= 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.iAvAx5pGWE/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.r78gllWsxb/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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.027865 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 16:39:02.783703) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 16:39:02.784556) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 676a32cdd41fd372f4c6df3a4954939f73a6ef02 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 676a32cdd41fd372f4c6df3a4954939f73a6ef02 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iAvAx5pGWE/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.r78gllWsxb/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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-06-27 16:39:02,863 truncating revision to first 12 chars 2016-06-27 16:39:02,863 Setting DEBUG logging. 2016-06-27 16:39:02,863 attempt 1/10 2016-06-27 16:39:02,863 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/676a32cdd41f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 16:39:03,579 unpacking tar archive at: mozilla-beta-676a32cdd41f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.958610 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 16:39:03.772924) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 16:39:03.773592) ========= script_repo_revision: 676a32cdd41fd372f4c6df3a4954939f73a6ef02 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 16:39:03.774057) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 16:39:03.774775) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 16:39:03.793150) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-06-27 16:39:03.793873) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iAvAx5pGWE/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.r78gllWsxb/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 16:39:03 INFO - MultiFileLogger online at 20160627 16:39:03 in /builds/slave/test 16:39:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 16:39:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:39:03 INFO - {'append_to_log': False, 16:39:03 INFO - 'base_work_dir': '/builds/slave/test', 16:39:03 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:39:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:39:03 INFO - 'branch': 'Mozilla-Beta', 16:39:03 INFO - 'buildbot_json_path': 'buildprops.json', 16:39:03 INFO - 'config_files': ('talos/mac_config.py',), 16:39:03 INFO - 'default_actions': ('clobber', 16:39:03 INFO - 'read-buildbot-config', 16:39:03 INFO - 'download-and-extract', 16:39:03 INFO - 'populate-webroot', 16:39:03 INFO - 'create-virtualenv', 16:39:03 INFO - 'install', 16:39:03 INFO - 'run-tests'), 16:39:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:39:03 INFO - 'download_minidump_stackwalk': True, 16:39:03 INFO - 'download_symbols': 'ondemand', 16:39:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:39:03 INFO - 'tooltool.py': '/tools/tooltool.py', 16:39:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:39:03 INFO - '/tools/misc-python/virtualenv.py')}, 16:39:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:39:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:39:03 INFO - 'installer_path': 'installer.exe', 16:39:03 INFO - 'log_level': 'info', 16:39:03 INFO - 'log_name': 'talos', 16:39:03 INFO - 'log_to_console': True, 16:39:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:39:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:39:03 INFO - 'opt_config_files': (), 16:39:03 INFO - 'pip_index': False, 16:39:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:39:03 INFO - 'cmd': ('bash', 16:39:03 INFO - '-c', 16:39:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:39:03 INFO - 'enabled': True, 16:39:03 INFO - 'halt_on_failure': False, 16:39:03 INFO - 'name': 'check_screen_resolution'},), 16:39:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:39:03 INFO - 'cmd': ('bash', 16:39:03 INFO - '-c', 16:39:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:39:03 INFO - 'enabled': True, 16:39:03 INFO - 'halt_on_failure': False, 16:39:03 INFO - 'name': 'check_screen_resolution'},), 16:39:03 INFO - 'run_cmd_checks_enabled': True, 16:39:03 INFO - 'sps_profile': False, 16:39:03 INFO - 'sps_profile_interval': 0, 16:39:03 INFO - 'suite': 'dromaeojs-e10s', 16:39:03 INFO - 'system_bits': '32', 16:39:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:39:03 INFO - 'title': 't-yosemite-r7-0122', 16:39:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:39:03 INFO - 'use_talos_json': True, 16:39:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:39:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:39:03 INFO - 'work_dir': 'build'} 16:39:03 INFO - ##### 16:39:03 INFO - ##### Running clobber step. 16:39:03 INFO - ##### 16:39:03 INFO - Running pre-action listener: _resource_record_pre_action 16:39:03 INFO - Running main action method: clobber 16:39:03 INFO - rmtree: /builds/slave/test/build 16:39:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:39:05 INFO - Running post-action listener: _resource_record_post_action 16:39:05 INFO - ##### 16:39:05 INFO - ##### Running read-buildbot-config step. 16:39:05 INFO - ##### 16:39:05 INFO - Running pre-action listener: _resource_record_pre_action 16:39:05 INFO - Running main action method: read_buildbot_config 16:39:05 INFO - Using buildbot properties: 16:39:05 INFO - { 16:39:05 INFO - "project": "", 16:39:05 INFO - "product": "firefox", 16:39:05 INFO - "script_repo_revision": "production", 16:39:05 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 16:39:05 INFO - "repository": "", 16:39:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 16:39:05 INFO - "buildid": "20160627144420", 16:39:05 INFO - "pgo_build": "False", 16:39:05 INFO - "basedir": "/builds/slave/test", 16:39:05 INFO - "buildnumber": 0, 16:39:05 INFO - "slavename": "t-yosemite-r7-0122", 16:39:05 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 16:39:05 INFO - "platform": "yosemite_r7", 16:39:05 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 16:39:05 INFO - "branch": "mozilla-beta", 16:39:05 INFO - "repo_path": "releases/mozilla-beta", 16:39:05 INFO - "revision": "676a32cdd41fd372f4c6df3a4954939f73a6ef02", 16:39:05 INFO - "stage_platform": "macosx64", 16:39:05 INFO - "builduid": "4360f4d245a549be90444bafc60905d0", 16:39:05 INFO - "slavebuilddir": "test" 16:39:05 INFO - } 16:39:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 16:39:05 INFO - Running post-action listener: _resource_record_post_action 16:39:05 INFO - ##### 16:39:05 INFO - ##### Running download-and-extract step. 16:39:05 INFO - ##### 16:39:05 INFO - Running pre-action listener: _resource_record_pre_action 16:39:05 INFO - Running main action method: download_and_extract 16:39:05 INFO - mkdir: /builds/slave/test/build/tests 16:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:05 INFO - https://queue.taskcluster.net/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:39:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 16:39:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 16:39:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 16:39:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 16:39:13 INFO - Downloaded 1165 bytes. 16:39:13 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 16:39:13 INFO - Using the following test package requirements: 16:39:13 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 16:39:13 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 16:39:13 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 16:39:13 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 16:39:13 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 16:39:13 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 16:39:13 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 16:39:13 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 16:39:13 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 16:39:13 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 16:39:13 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 16:39:13 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 16:39:13 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 16:39:13 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 16:39:13 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 16:39:13 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 16:39:13 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 16:39:13 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 16:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:13 INFO - https://queue.taskcluster.net/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:39:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 16:39:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 16:39:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 16:39:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 16:39:17 INFO - Downloaded 18350366 bytes. 16:39:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:39:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:39:20 INFO - Return code: 0 16:39:20 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 16:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:20 INFO - https://queue.taskcluster.net/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:39:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 16:39:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 16:39:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 16:39:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 16:39:35 INFO - Downloaded 18350366 bytes. 16:39:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:39:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:39:38 INFO - Return code: 0 16:39:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:38 INFO - https://queue.taskcluster.net/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:39:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 16:39:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 16:39:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 16:39:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 16:39:39 INFO - Downloaded 10840145 bytes. 16:39:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:39:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 16:39:39 INFO - Return code: 0 16:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:39 INFO - https://queue.taskcluster.net/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 16:39:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 16:39:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 16:39:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 16:39:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 16:39:46 INFO - Downloaded 86199828 bytes. 16:39:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 16:39:46 INFO - mkdir: /builds/slave/test/properties 16:39:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:39:46 INFO - Writing to file /builds/slave/test/properties/build_url 16:39:46 INFO - Contents: 16:39:46 INFO - build_url:https://queue.taskcluster.net/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 16:39:47 INFO - Running post-action listener: _resource_record_post_action 16:39:47 INFO - Running post-action listener: set_extra_try_arguments 16:39:47 INFO - ##### 16:39:47 INFO - ##### Running populate-webroot step. 16:39:47 INFO - ##### 16:39:47 INFO - Running pre-action listener: _resource_record_pre_action 16:39:47 INFO - Running main action method: populate_webroot 16:39:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:39:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:39:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:39:47 INFO - '--tppagecycles', 16:39:47 INFO - '7'], 16:39:47 INFO - 'tests': ['tsvgm']}}, 16:39:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:39:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:39:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:39:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:39:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:39:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:39:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:47 INFO - 'talos_options': ['--disable-e10s'], 16:39:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:39:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:39:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:47 INFO - 'talos_options': ['--disable-e10s'], 16:39:47 INFO - 'tests': ['damp', 'tps']}, 16:39:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:47 INFO - 'tests': ['damp', 'tps']}, 16:39:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:39:47 INFO - 'tests': ['dromaeo_dom']}, 16:39:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:39:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:39:47 INFO - 'tests': ['a11yr', 16:39:47 INFO - 'ts_paint', 16:39:47 INFO - 'tpaint', 16:39:47 INFO - 'sessionrestore', 16:39:47 INFO - 'sessionrestore_no_auto_restore', 16:39:47 INFO - 'tabpaint']}, 16:39:47 INFO - 'other-e10s': {'tests': ['a11yr', 16:39:47 INFO - 'ts_paint', 16:39:47 INFO - 'tpaint', 16:39:47 INFO - 'sessionrestore', 16:39:47 INFO - 'sessionrestore_no_auto_restore', 16:39:47 INFO - 'tabpaint']}, 16:39:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:39:47 INFO - 'ts_paint', 16:39:47 INFO - 'tpaint', 16:39:47 INFO - 'sessionrestore', 16:39:47 INFO - 'sessionrestore_no_auto_restore', 16:39:47 INFO - 'tabpaint']}, 16:39:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:39:47 INFO - 'ts_paint', 16:39:47 INFO - 'tpaint', 16:39:47 INFO - 'sessionrestore', 16:39:47 INFO - 'sessionrestore_no_auto_restore', 16:39:47 INFO - 'tabpaint']}, 16:39:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:39:47 INFO - 'tests': ['a11yr', 16:39:47 INFO - 'ts_paint', 16:39:47 INFO - 'tpaint', 16:39:47 INFO - 'sessionrestore', 16:39:47 INFO - 'sessionrestore_no_auto_restore', 16:39:47 INFO - 'tabpaint']}, 16:39:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:39:47 INFO - 'tests': ['a11yr', 16:39:47 INFO - 'ts_paint', 16:39:47 INFO - 'tpaint', 16:39:47 INFO - 'sessionrestore', 16:39:47 INFO - 'sessionrestore_no_auto_restore', 16:39:47 INFO - 'tabpaint']}, 16:39:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:39:47 INFO - 'tests': ['tsvgx', 16:39:47 INFO - 'tsvgr_opacity', 16:39:47 INFO - 'tart', 16:39:47 INFO - 'tscrollx', 16:39:47 INFO - 'cart']}, 16:39:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:39:47 INFO - 'tsvgr_opacity', 16:39:47 INFO - 'tart', 16:39:47 INFO - 'tscrollx', 16:39:47 INFO - 'cart']}, 16:39:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:47 INFO - 'talos_options': ['--disable-e10s'], 16:39:47 INFO - 'tests': ['tp5o']}, 16:39:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:47 INFO - 'tests': ['tp5o']}, 16:39:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:47 INFO - 'talos_options': ['--disable-e10s', 16:39:47 INFO - '--xperf_path', 16:39:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:39:47 INFO - 'tests': ['tp5n']}, 16:39:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:39:47 INFO - 'talos_options': ['--xperf_path', 16:39:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:39:47 INFO - 'tests': ['tp5n']}}, 16:39:47 INFO - 'talos.zip': {'path': '', 16:39:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:39:47 INFO - Running post-action listener: _resource_record_post_action 16:39:47 INFO - ##### 16:39:47 INFO - ##### Running create-virtualenv step. 16:39:47 INFO - ##### 16:39:47 INFO - Running pre-action listener: _resource_record_pre_action 16:39:47 INFO - Running main action method: create_virtualenv 16:39:47 INFO - Creating virtualenv /builds/slave/test/build/venv 16:39:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:39:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:39:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:39:48 INFO - Using real prefix '/tools/python27' 16:39:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:39:48 INFO - Installing distribute.............................................................................................................................................................................................done. 16:39:51 INFO - Installing pip.................done. 16:39:51 INFO - Return code: 0 16:39:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:51 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 0x10c90ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c91b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f734623b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7aae00>, '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 0x10c613db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7a5b20>, '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.iAvAx5pGWE/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.r78gllWsxb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:39:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:39:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:39:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iAvAx5pGWE/Render', 16:39:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:39:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:39:51 INFO - 'HOME': '/Users/cltbld', 16:39:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:39:51 INFO - 'LOGNAME': 'cltbld', 16:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:51 INFO - 'MOZ_NO_REMOTE': '1', 16:39:51 INFO - 'NO_EM_RESTART': '1', 16:39:51 INFO - 'PAGER': '/bin/cat', 16:39:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:51 INFO - 'PWD': '/builds/slave/test', 16:39:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:39:51 INFO - 'SHELL': '/bin/bash', 16:39:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r78gllWsxb/Listeners', 16:39:51 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 16:39:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:39:51 INFO - 'USER': 'cltbld', 16:39:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:39:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:51 INFO - 'XPC_FLAGS': '0x0', 16:39:51 INFO - 'XPC_SERVICE_NAME': '0', 16:39:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:39:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:39:51 INFO - Cleaning up... 16:39:51 INFO - Return code: 0 16:39:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:51 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c90ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c91b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f734623b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7aae00>, '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 0x10c613db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7a5b20>, '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.iAvAx5pGWE/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.r78gllWsxb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:39:51 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>=0.7.1'] in /builds/slave/test/build 16:39:51 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>=0.7.1 16:39:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iAvAx5pGWE/Render', 16:39:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:39:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:39:51 INFO - 'HOME': '/Users/cltbld', 16:39:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:39:51 INFO - 'LOGNAME': 'cltbld', 16:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:51 INFO - 'MOZ_NO_REMOTE': '1', 16:39:51 INFO - 'NO_EM_RESTART': '1', 16:39:51 INFO - 'PAGER': '/bin/cat', 16:39:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:51 INFO - 'PWD': '/builds/slave/test', 16:39:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:39:51 INFO - 'SHELL': '/bin/bash', 16:39:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r78gllWsxb/Listeners', 16:39:51 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 16:39:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:39:51 INFO - 'USER': 'cltbld', 16:39:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:39:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:51 INFO - 'XPC_FLAGS': '0x0', 16:39:51 INFO - 'XPC_SERVICE_NAME': '0', 16:39:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:52 INFO - Downloading/unpacking psutil>=0.7.1 16:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:39:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:39:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:39:55 INFO - Installing collected packages: psutil 16:39:55 INFO - Running setup.py install for psutil 16:39:55 INFO - building 'psutil._psutil_osx' extension 16:39:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 16:39:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 16:39:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 16:39:56 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 16:39:56 INFO - building 'psutil._psutil_posix' extension 16:39:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 16:39:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:39:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:39:56 INFO - ^ 16:39:56 INFO - 1 warning generated. 16:39:56 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 16:39:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:39:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:39:56 INFO - Successfully installed psutil 16:39:56 INFO - Cleaning up... 16:39:57 INFO - Return code: 0 16:39:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:39:57 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:57 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:57 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c90ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c91b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f734623b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7aae00>, '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 0x10c613db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7a5b20>, '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.iAvAx5pGWE/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.r78gllWsxb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:39:57 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.0.0'] in /builds/slave/test/build 16:39:57 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.0.0 16:39:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iAvAx5pGWE/Render', 16:39:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:39:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:39:57 INFO - 'HOME': '/Users/cltbld', 16:39:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:39:57 INFO - 'LOGNAME': 'cltbld', 16:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:57 INFO - 'MOZ_NO_REMOTE': '1', 16:39:57 INFO - 'NO_EM_RESTART': '1', 16:39:57 INFO - 'PAGER': '/bin/cat', 16:39:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:57 INFO - 'PWD': '/builds/slave/test', 16:39:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:39:57 INFO - 'SHELL': '/bin/bash', 16:39:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r78gllWsxb/Listeners', 16:39:57 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 16:39:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:39:57 INFO - 'USER': 'cltbld', 16:39:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:39:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:57 INFO - 'XPC_FLAGS': '0x0', 16:39:57 INFO - 'XPC_SERVICE_NAME': '0', 16:39:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:39:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:39:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:39:59 INFO - Installing collected packages: mozsystemmonitor 16:39:59 INFO - Running setup.py install for mozsystemmonitor 16:39:59 INFO - Successfully installed mozsystemmonitor 16:39:59 INFO - Cleaning up... 16:40:00 INFO - Return code: 0 16:40:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:40:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c90ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c91b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f734623b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7aae00>, '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 0x10c613db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7a5b20>, '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.iAvAx5pGWE/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.r78gllWsxb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:40:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:40:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:40:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iAvAx5pGWE/Render', 16:40:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:40:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:40:00 INFO - 'HOME': '/Users/cltbld', 16:40:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:40:00 INFO - 'LOGNAME': 'cltbld', 16:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:00 INFO - 'MOZ_NO_REMOTE': '1', 16:40:00 INFO - 'NO_EM_RESTART': '1', 16:40:00 INFO - 'PAGER': '/bin/cat', 16:40:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:00 INFO - 'PWD': '/builds/slave/test', 16:40:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:40:00 INFO - 'SHELL': '/bin/bash', 16:40:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r78gllWsxb/Listeners', 16:40:00 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 16:40:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:40:00 INFO - 'USER': 'cltbld', 16:40:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:40:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:00 INFO - 'XPC_FLAGS': '0x0', 16:40:00 INFO - 'XPC_SERVICE_NAME': '0', 16:40:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:40:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:00 INFO - Downloading/unpacking blobuploader==1.2.4 16:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:40:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:02 INFO - Downloading blobuploader-1.2.4.tar.gz 16:40:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:40:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:40:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:40:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:40:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:03 INFO - Downloading docopt-0.6.1.tar.gz 16:40:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:40:03 INFO - Installing collected packages: blobuploader, requests, docopt 16:40:03 INFO - Running setup.py install for blobuploader 16:40:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:40:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:40:04 INFO - Running setup.py install for requests 16:40:04 INFO - Running setup.py install for docopt 16:40:04 INFO - Successfully installed blobuploader requests docopt 16:40:04 INFO - Cleaning up... 16:40:04 INFO - Return code: 0 16:40:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c90ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c91b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f734623b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7aae00>, '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 0x10c613db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7a5b20>, '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.iAvAx5pGWE/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.r78gllWsxb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:40:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:40:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:40:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iAvAx5pGWE/Render', 16:40:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:40:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:40:04 INFO - 'HOME': '/Users/cltbld', 16:40:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:40:04 INFO - 'LOGNAME': 'cltbld', 16:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:04 INFO - 'MOZ_NO_REMOTE': '1', 16:40:04 INFO - 'NO_EM_RESTART': '1', 16:40:04 INFO - 'PAGER': '/bin/cat', 16:40:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:04 INFO - 'PWD': '/builds/slave/test', 16:40:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:40:04 INFO - 'SHELL': '/bin/bash', 16:40:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r78gllWsxb/Listeners', 16:40:04 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 16:40:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:40:04 INFO - 'USER': 'cltbld', 16:40:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:40:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:04 INFO - 'XPC_FLAGS': '0x0', 16:40:04 INFO - 'XPC_SERVICE_NAME': '0', 16:40:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:40:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:40:05 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-b3pYEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:40:05 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-jdoy3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:40:05 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-DkKyOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:40:05 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-wK99TK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:40:05 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-wwpqtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:40:05 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-VB4IzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:40:05 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-GjUoNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:40:05 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-eWJ_2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:40:05 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-Y7YqHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:40:06 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-1iQZmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:40:06 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-ntJEdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:40:06 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-zOb8sm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:40:06 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-igjdJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:40:06 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-TCY7dT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:40:06 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-4fPjZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:40:06 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-riR7a7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:40:06 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-Ugmayp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:40:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:40:06 INFO - Running setup.py install for manifestparser 16:40:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:40:06 INFO - Running setup.py install for mozcrash 16:40:07 INFO - Running setup.py install for mozdebug 16:40:07 INFO - Running setup.py install for mozdevice 16:40:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:40:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:40:07 INFO - Running setup.py install for mozfile 16:40:07 INFO - Running setup.py install for mozhttpd 16:40:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:40:07 INFO - Running setup.py install for mozinfo 16:40:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:40:07 INFO - Running setup.py install for mozInstall 16:40:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:40:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:40:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:40:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:40:07 INFO - Running setup.py install for mozleak 16:40:08 INFO - Running setup.py install for mozlog 16:40:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:40:08 INFO - Running setup.py install for moznetwork 16:40:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:40:08 INFO - Running setup.py install for mozprocess 16:40:08 INFO - Running setup.py install for mozprofile 16:40:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:40:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:40:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:40:08 INFO - Running setup.py install for mozrunner 16:40:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:40:08 INFO - Running setup.py install for mozscreenshot 16:40:09 INFO - Running setup.py install for moztest 16:40:09 INFO - Running setup.py install for mozversion 16:40:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:40:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:40:09 INFO - Cleaning up... 16:40:09 INFO - Return code: 0 16:40:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:40:09 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:09 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:40:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:09 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 0x10c90ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c91b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f734623b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7aae00>, '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 0x10c613db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7a5b20>, '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.iAvAx5pGWE/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.r78gllWsxb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:40:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:40:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:40:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iAvAx5pGWE/Render', 16:40:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:40:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:40:09 INFO - 'HOME': '/Users/cltbld', 16:40:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:40:09 INFO - 'LOGNAME': 'cltbld', 16:40:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:09 INFO - 'MOZ_NO_REMOTE': '1', 16:40:09 INFO - 'NO_EM_RESTART': '1', 16:40:09 INFO - 'PAGER': '/bin/cat', 16:40:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:40:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:09 INFO - 'PWD': '/builds/slave/test', 16:40:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:40:09 INFO - 'SHELL': '/bin/bash', 16:40:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r78gllWsxb/Listeners', 16:40:09 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 16:40:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:40:09 INFO - 'USER': 'cltbld', 16:40:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:40:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:40:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:09 INFO - 'XPC_FLAGS': '0x0', 16:40:09 INFO - 'XPC_SERVICE_NAME': '0', 16:40:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:40:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:40:09 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-eaVRMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:40:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:40:09 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-vTaIy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:40:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:40:09 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-I2Gj6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:40:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:40:10 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-cXkLns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:40:10 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)) 16:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:40:10 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-j1K1H1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:40:10 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-oNKkDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:40:10 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-ZaQXIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:40:10 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-kaQ3Zc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:40:10 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-y00LIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:40:10 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-bwbQtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:40:10 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-PkUEpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:40:10 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-hXvTiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:40:10 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-C03Jvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:40:11 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-BPOFN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:40:11 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-iCnUqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:40:11 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-7NHUlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:40:11 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)) 16:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:40:11 INFO - Running setup.py (path:/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/pip-XzI_Gu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:40:11 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)) 16:40:11 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)) 16:40:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:40: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 16:40: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 16:40: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 16:40: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 16:40: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 16:40: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 16:40:14 INFO - Downloading blessings-1.6.tar.gz 16:40:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:40:14 INFO - Installing collected packages: blessings 16:40:14 INFO - Running setup.py install for blessings 16:40:14 INFO - Successfully installed blessings 16:40:14 INFO - Cleaning up... 16:40:14 INFO - Return code: 0 16:40:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:40:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:40:14 INFO - Reading from file tmpfile_stdout 16:40:14 INFO - Current package versions: 16:40:14 INFO - blessings == 1.6 16:40:14 INFO - blobuploader == 1.2.4 16:40:14 INFO - docopt == 0.6.1 16:40:14 INFO - manifestparser == 1.1 16:40:14 INFO - mozInstall == 1.12 16:40:14 INFO - mozcrash == 0.17 16:40:14 INFO - mozdebug == 0.1 16:40:14 INFO - mozdevice == 0.48 16:40:14 INFO - mozfile == 1.2 16:40:14 INFO - mozhttpd == 0.7 16:40:14 INFO - mozinfo == 0.9 16:40:14 INFO - mozleak == 0.1 16:40:14 INFO - mozlog == 3.1 16:40:14 INFO - moznetwork == 0.27 16:40:14 INFO - mozprocess == 0.22 16:40:14 INFO - mozprofile == 0.28 16:40:14 INFO - mozrunner == 6.11 16:40:14 INFO - mozscreenshot == 0.1 16:40:14 INFO - mozsystemmonitor == 0.0 16:40:14 INFO - moztest == 0.7 16:40:14 INFO - mozversion == 1.4 16:40:14 INFO - psutil == 3.1.1 16:40:14 INFO - requests == 1.2.3 16:40:14 INFO - wsgiref == 0.1.2 16:40:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:40: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:40:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c90ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c91b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f734623b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7aae00>, '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 0x10c613db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7a5b20>, '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.iAvAx5pGWE/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.r78gllWsxb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:40:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:40:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iAvAx5pGWE/Render', 16:40:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:40:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:40:14 INFO - 'HOME': '/Users/cltbld', 16:40:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:40:14 INFO - 'LOGNAME': 'cltbld', 16:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:14 INFO - 'MOZ_NO_REMOTE': '1', 16:40:14 INFO - 'NO_EM_RESTART': '1', 16:40:14 INFO - 'PAGER': '/bin/cat', 16:40:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:14 INFO - 'PWD': '/builds/slave/test', 16:40:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:40:14 INFO - 'SHELL': '/bin/bash', 16:40:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r78gllWsxb/Listeners', 16:40:14 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 16:40:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:40:14 INFO - 'USER': 'cltbld', 16:40:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:40:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:14 INFO - 'XPC_FLAGS': '0x0', 16:40:14 INFO - 'XPC_SERVICE_NAME': '0', 16:40:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:40:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:40:15 INFO - Cleaning up... 16:40:15 INFO - Return code: 0 16:40:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40:15 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 0x10c90ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c91b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f734623b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7aae00>, '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 0x10c613db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7a5b20>, '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.iAvAx5pGWE/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.r78gllWsxb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:40:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:40:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iAvAx5pGWE/Render', 16:40:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:40:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:40:15 INFO - 'HOME': '/Users/cltbld', 16:40:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:40:15 INFO - 'LOGNAME': 'cltbld', 16:40:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:15 INFO - 'MOZ_NO_REMOTE': '1', 16:40:15 INFO - 'NO_EM_RESTART': '1', 16:40:15 INFO - 'PAGER': '/bin/cat', 16:40:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:40:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:15 INFO - 'PWD': '/builds/slave/test', 16:40:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:40:15 INFO - 'SHELL': '/bin/bash', 16:40:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r78gllWsxb/Listeners', 16:40:15 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 16:40:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:40:15 INFO - 'USER': 'cltbld', 16:40:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:40:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:40:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:15 INFO - 'XPC_FLAGS': '0x0', 16:40:15 INFO - 'XPC_SERVICE_NAME': '0', 16:40:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:40:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:15 INFO - Downloading/unpacking jsonschema 16:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:40:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:40:17 INFO - Downloading/unpacking functools32 (from jsonschema) 16:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:40:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:18 INFO - Downloading functools32-3.2.3-2.tar.gz 16:40:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:40:18 INFO - warning: no files found matching '*.txt' 16:40:18 INFO - no previously-included directories found matching 'build' 16:40:18 INFO - no previously-included directories found matching 'dist' 16:40:18 INFO - no previously-included directories found matching '.git*' 16:40:18 INFO - Installing collected packages: jsonschema, functools32 16:40:18 INFO - Running setup.py install for functools32 16:40:18 INFO - warning: no files found matching '*.txt' 16:40:18 INFO - no previously-included directories found matching 'build' 16:40:18 INFO - no previously-included directories found matching 'dist' 16:40:18 INFO - no previously-included directories found matching '.git*' 16:40:18 INFO - Successfully installed jsonschema functools32 16:40:18 INFO - Cleaning up... 16:40:18 INFO - Return code: 0 16:40:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:40: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:40:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:40:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:40:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:40: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c90ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c91b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f734623b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7aae00>, '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 0x10c613db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7a5b20>, '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.iAvAx5pGWE/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.r78gllWsxb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:40: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', 'flake8'] in /builds/slave/test/build 16:40: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 flake8 16:40:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iAvAx5pGWE/Render', 16:40:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:40:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:40:18 INFO - 'HOME': '/Users/cltbld', 16:40:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:40:18 INFO - 'LOGNAME': 'cltbld', 16:40:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:18 INFO - 'MOZ_NO_REMOTE': '1', 16:40:18 INFO - 'NO_EM_RESTART': '1', 16:40:18 INFO - 'PAGER': '/bin/cat', 16:40:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:40:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:18 INFO - 'PWD': '/builds/slave/test', 16:40:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:40:18 INFO - 'SHELL': '/bin/bash', 16:40:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r78gllWsxb/Listeners', 16:40:18 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 16:40:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:40:18 INFO - 'USER': 'cltbld', 16:40:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:40:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:40:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:18 INFO - 'XPC_FLAGS': '0x0', 16:40:18 INFO - 'XPC_SERVICE_NAME': '0', 16:40:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:40:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:40:18 INFO - Downloading/unpacking flake8 16:40: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 16:40: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 16:40: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 16:40: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 16:40: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 16:40: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 16:40:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:40:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:40: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 16:40: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 16:40: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 16:40: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 16:40: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 16:40: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 16:40:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:40:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:40: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 16:40: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 16:40: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 16:40: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 16:40: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 16:40: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 16:40:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:40:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:40:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:40:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:40:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:40:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:40:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:40:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:40:22 INFO - no previously-included directories found matching 'docs/_build' 16:40:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:40:22 INFO - Running setup.py install for pep8 16:40:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:40:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:40:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:40:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:40:22 INFO - no previously-included directories found matching 'docs/_build' 16:40:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:40:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:40:23 INFO - Cleaning up... 16:40:23 INFO - Return code: 0 16:40:23 INFO - Running post-action listener: _resource_record_post_action 16:40:23 INFO - Running post-action listener: _start_resource_monitoring 16:40:23 INFO - Starting resource monitoring. 16:40:23 INFO - ##### 16:40:23 INFO - ##### Running install step. 16:40:23 INFO - ##### 16:40:23 INFO - Running pre-action listener: _resource_record_pre_action 16:40:23 INFO - Running main action method: install 16:40:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:40:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:40:23 INFO - Reading from file tmpfile_stdout 16:40:23 INFO - Detecting whether we're running mozinstall >=1.0... 16:40:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:40:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:40:23 INFO - Reading from file tmpfile_stdout 16:40:23 INFO - Output received: 16:40:23 INFO - Usage: mozinstall [options] installer 16:40:23 INFO - Options: 16:40:23 INFO - -h, --help show this help message and exit 16:40:23 INFO - -d DEST, --destination=DEST 16:40:23 INFO - Directory to install application into. [default: 16:40:23 INFO - "/builds/slave/test"] 16:40:23 INFO - --app=APP Application being installed. [default: firefox] 16:40:23 INFO - mkdir: /builds/slave/test/build/application 16:40:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:40:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 16:40:45 INFO - Reading from file tmpfile_stdout 16:40:45 INFO - Output received: 16:40:45 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 16:40:45 INFO - Running post-action listener: _resource_record_post_action 16:40:45 INFO - ##### 16:40:45 INFO - ##### Running run-tests step. 16:40:45 INFO - ##### 16:40:45 INFO - Running pre-action listener: _resource_record_pre_action 16:40:45 INFO - Running main action method: run_tests 16:40:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:40:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:40:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:40:45 INFO - 2016-06-27 16:40:45.376 screenresolution[1650:8011] starting screenresolution argv=screenresolution get 16:40:45 INFO - 2016-06-27 16:40:45.379 screenresolution[1650:8011] Display 0: 1600x1200x32@60 16:40:45 INFO - 2016-06-27 16:40:45.385 screenresolution[1651:8013] starting screenresolution argv=screenresolution list 16:40:45 INFO - Available Modes on Display 0 16:40:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:40:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:40:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:40:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:40:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:40:45 INFO - Intel Iris: 16:40:45 INFO - Chipset Model: Intel Iris 16:40:45 INFO - Type: GPU 16:40:45 INFO - Bus: Built-In 16:40:45 INFO - VRAM (Dynamic, Max): 1536 MB 16:40:45 INFO - Vendor: Intel (0x8086) 16:40:45 INFO - Device ID: 0x0a2e 16:40:45 INFO - Revision ID: 0x0009 16:40:45 INFO - Displays: 16:40:45 INFO - Display: 16:40:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:40:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:40:45 INFO - Display Serial Number: 1600x1200 60 16:40:45 INFO - Main Display: Yes 16:40:45 INFO - Mirror: Off 16:40:45 INFO - Online: Yes 16:40:45 INFO - Rotation: Supported 16:40:45 INFO - Return code: 0 16:40:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:40:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:40:45 INFO - Python 2.7.3 16:40:45 INFO - Return code: 0 16:40:45 INFO - grabbing minidump binary from tooltool 16:40:45 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:40:45 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7aae00>, '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 0x10c613db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7a5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:40:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:40:45 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 16:40:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:40:45 INFO - Return code: 0 16:40:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:40:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:40:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:40:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:40:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:40:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:40:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:40:46 INFO - Return code: 0 16:40:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0122', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:40:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0122 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:40:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iAvAx5pGWE/Render', 16:40:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:40:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:40:46 INFO - 'HOME': '/Users/cltbld', 16:40:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:40:46 INFO - 'LOGNAME': 'cltbld', 16:40:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:40:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:40:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:46 INFO - 'MOZ_NO_REMOTE': '1', 16:40:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:40:46 INFO - 'NO_EM_RESTART': '1', 16:40:46 INFO - 'PAGER': '/bin/cat', 16:40:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:40:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:46 INFO - 'PWD': '/builds/slave/test', 16:40:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:40:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:40:46 INFO - 'SHELL': '/bin/bash', 16:40:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r78gllWsxb/Listeners', 16:40:46 INFO - 'TMPDIR': '/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/', 16:40:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:40:46 INFO - 'USER': 'cltbld', 16:40:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:40:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:40:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:46 INFO - 'XPC_FLAGS': '0x0', 16:40:46 INFO - 'XPC_SERVICE_NAME': '0', 16:40:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:40:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0122', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:40:47 INFO - mozversion application_buildid: 20160627144420 16:40:47 INFO - mozversion application_changeset: 676a32cdd41fd372f4c6df3a4954939f73a6ef02 16:40:47 INFO - mozversion application_display_name: Firefox 16:40:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:40:47 INFO - mozversion application_name: Firefox 16:40:47 INFO - mozversion application_remotingname: firefox 16:40:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:40:47 INFO - mozversion application_vendor: Mozilla 16:40:47 INFO - mozversion application_version: 48.0 16:40:47 INFO - mozversion platform_buildid: 20160627144420 16:40:47 INFO - mozversion platform_changeset: 676a32cdd41fd372f4c6df3a4954939f73a6ef02 16:40:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:40:47 INFO - mozversion platform_version: 48.0 16:40:47 INFO - using testdate: 1467070847 16:40:47 INFO - actual date: 1467070847 16:40:47 INFO - starting webserver on 'localhost:49283' 16:40:47 INFO - SUITE-START | Running 2 tests 16:40:47 INFO - TEST-START | dromaeo_css 16:40:47 INFO - operating with platform_type : mac_ 16:40:47 INFO - Initialising browser for dromaeo_css test... 16:40:47 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/tmpwLN_2v/profile http://localhost:49283/getInfo.html) 16:40:50 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 16:40:50 INFO - PROCESS | 1669 | colorDepth:24 16:40:50 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 16:40:50 INFO - PROCESS | 1669 | __metrics 16:40:50 ERROR - PROCESS | 1669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 16:40:50 INFO - TEST-INFO | 1669: exit 0 16:40:50 INFO - Browser initialized. 16:40:50 INFO - Running cycle 1/1 for dromaeo_css test... 16:40:50 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/tmpwLN_2v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:41:02 INFO - PROCESS | 1674 | RSS: Main: 170921984 16:41:02 INFO - PROCESS | 1674 | 16:41:52 INFO - PROCESS | 1674 | 1467070912226 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] 16:44:02 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49283/tests/dromaeo/cssquery-ext.html) 16:44:03 INFO - PROCESS | 1674 | RSS: Main: 181260288 16:44:03 INFO - PROCESS | 1674 | 16:47:05 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-ext.html (next: http://localhost:49283/tests/dromaeo/cssquery-jquery.html) 16:47:06 INFO - PROCESS | 1674 | RSS: Main: 192249856 16:47:06 INFO - PROCESS | 1674 | 16:50:08 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49283/tests/dromaeo/cssquery-mootools.html) 16:50:08 INFO - PROCESS | 1674 | RSS: Main: 194146304 16:50:08 INFO - PROCESS | 1674 | 16:53:10 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49283/tests/dromaeo/cssquery-prototype.html) 16:53:11 INFO - PROCESS | 1674 | RSS: Main: 198361088 16:53:11 INFO - PROCESS | 1674 | 16:56:13 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49283/tests/dromaeo/cssquery-yui.html) 16:56:14 INFO - PROCESS | 1674 | RSS: Main: 197427200 16:56:14 INFO - PROCESS | 1674 | 16:59:16 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-yui.html (next: http://localhost:49283/tests/dromaeo/cssquery-dojo.html) 16:59:16 INFO - PROCESS | 1674 | RSS: Main: 202145792 16:59:16 INFO - PROCESS | 1674 | 16:59:16 INFO - PROCESS | 1674 | __start_tp_report 16:59:16 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 16:59:16 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 16:59:16 INFO - PROCESS | 1674 | |i|pagename|runs| 16:59:16 INFO - PROCESS | 1674 | |0;dojo.html;3665.395209790385;3693.169036966682;3717.9814100929493;3733.7199710021755;3745.082454798575;6002.579819412643;6120.571559990803;6124.173236613067;6173.9999999999945;6176.660283684396;4997.625178111638;6085.330613632497;6137.72380242889;6169.0437982112735;6180.227471566043;5450.945490545093;5502.203479599084;5543.25166102575;5572.3870374258795;5628.493435590796;5421.780099477625;5422.40353561108;5506.862328441781;5510.972445137789;5883.529317654577;5040.773165207556;5542.722863856811;5564.221009058735;5566.832995010136;5567.693776842272;5552.083906155459;5567.638103523258;5571;5582.944170558283;5598.412166722476;5328.360596728378;5356.517913387775;5422.43064478228;5465.480779325958;5467.20725494805;4389.736615803062;5990.73041713124;6011.6393016418715;6032.9698351508405;6062.545309101835;6339.587926784744;6403.679816009181;6410.134631824691;6413.39072788089;6416.903746443807;6326.49388048955;6381.936180638227;6435.549511534195;6497.805065848032;6506.967465162691;5103.821366252238;6163.753449862;6170.691465426711;6183.134361189437;6201.565890387675;6408.743650254031;6578.27638959714;6607.174103237096;6624.7681331154145;6635.369639884203;6260.186175797208;6302.054691796267;6314.463270621956;6335.334789847092;6355.936440635627;6378.202724659418;6384.457321127663;6403.263624683128;6412.23053233615;6455.322191169954;6208.317085120633;6320.115183874262;6326.177596912372;6327.746890124436;6340.144080549159;6320.115183874262;6382.904256436157;6385.233771947396;6390.4248617624635;6399.616023038632;5122.9743851281255;5160.870978225499;5162.096633089194;5190.870228244248;5195.376554813447;4581.129585378767;4625;4679.087577922272;4699.882502937454;4732.692374995614;4732.787024583902;4819.903601927942;6073.939260607337;6120.294761999619;6162.969185154046;6447.451966582893;6458.22501299847;6473;6482.481401487869;6501.739930402731;5234.743661521207;5242.344706911636;6158.692065396713;6202.0696895465135;6223.0354295084335;4272.978635106804;4728.699607607935;5662.405447428043;5675.659460432387;5683.403242659544;6706.83232919181;6731.990201469819;6732.057511948331;6737.3599508046655;6737.52837301394;5301.310829592128;5996.860596486654;6021.675231449074;6472.93980594111;6564.310747371648;6070.6357618543025;6777.322267773183;6792.694328755119;6813.591184528944;6816.693248803716;5362.973185134206;6435.774747883802;6438.903416448663;6444.742210311535;6493.610383377012;6326.588771729823;6456.289808121197;6518.73925042993;6569.178852643419;6575.473962082926;6286.339934306832;6300.905486417616;6330;6343.746250149942;6372.55392122547;5045.899082018265;6177.351378105234;6248.218972628421;6274.560780745304;6302.495800336053;5093.796248150033;5236.821715114069;5910.674912879833;6129.877402452015;6202.906956395567;6266.624002559861;6282.277538083179;6288.496920246461;6290.937090629218;6326.145970293951;6097.7865774697675;6219.222597175353;6241.625502469867;6245.937540624535;6251.68741562911 16:59:16 INFO - PROCESS | 1674 | |1;ext.html;545.5381784728611;562.8480310316214;580.5181699189671;580.5297708855826;612.5222326585265;38738.41892371617;39435.60564394362;39981.8000909995;40103.79948100259;40270.1945961081;41208.793956030255;41259.793701031456;41472.58527414725;42125.57874421255;42190.57809421913;9628.903710962906;9787.46168960707;9804.754881127958;9820.950895245514;9871.40771553709;9697.806043879118;9907.702768916944;9937.850932236022;9945.254105942047;9958;9842.360246583985;9873.851892221623;9879.16027137694;9899.604015839357;9964.551595178198;9824.508774561244;9854.753631159207;9886.505674716307;9899.604015839357;9909.504524773733;9725.756856078655;9762.36544624597;9819.656312029116;9841.557129929099;9882.752931176707;34118.14704632379;40138.59861401407;40632.59367406347;41036.58963410358;41043.38434923479;3123.875044998197;3258.462353711635;3272.705456508902;3284.293876816472;3449.6205417404067;21827.454313642287;26818.329541761417;27146.185614431597;27458.90164393422;27657.44685106307;2665.453582015682;2686.8043720544365;2726.6864310604337;2739.205630367191;2801.453716525278;245130;269315.2671183217;294202;317117;320529;35217.64782352195;35269.29461410809;35324.82337588347;38068;38636.420453693216;37632;37644;37682.81158594244;37740.05649858776;38112;16490.010599364075;16669.583260418345;16683;16714.6657066858;16718.665626687398;13892.652683682989;13968.790468142986;14147.787783183261;14149.009569330254;14175.78736318956;8207.220314070153;8240.793980150424;8244.216799404046;8477.152284771597;8560.14398560139;3606.4770608261656;3623.0942264433893;3635.981925060987;3651.1419816343137;3657;961.1349785193242;1052.768390953989;1135.7785231879704;1148.3397046698183;1173.0908545877014;30297.848510757747;30440.695593043787;30555.847220764197;30930;31244.531332030037;1185.9445093866466;1213.0659392267905;1229.6126720083146;1238.1704258146883;1308.6008767326057;13697.863021369858;15457.072575645498;15691.372345106069;15691.764623530657;15796.842031579537;556381;596290;613014;670431;676657;62386.376136238054;62849.371506284355;62877.68561157165;62881;63267.05099423512;1298.2729671384054;1533.2793587013862;1547.5280039588033;1553.766934959765;1561.3988614383545;29527.26181845471;29964.850175748983;30083.548746768378;30575;30734;52271.21593176181;53098.4690153109;53132.46867531275;53358.733206333716;53489;496972;580084;583992;584829;585279;26091.217263482125;27058.72941270562;27243.455130897666;27424.58863117015;27491.450170996868;46721.53278467308;47483.52516474791;48094.5190548104;48802.511974881214;48938.26592601185;38270;39474.01314967034;39538.604613953496;39854.202915940936;40161.1967760649;38482.80758596189;38532;38625.22749544937;39122.608773911896;39301.01747456336;38633.80683096567;38847.6115238844;39158.80420597879;40325.99185020281;40349.59650403458;26473.602895956963;30369.696303036686;32913.83543082269;33137.50293745644;33302;25137.622935655614;25199.74800251974;25417.872910635328;25460.872695636404;25516.362090947874 16:59:16 INFO - PROCESS | 1674 | |2;jquery.html;416.3089271808798;417.9791010449477;420.8106352141537;426.18811164731187;431.26684636118586;20623.38129856105;20918.849463279512;21272;21345.35963921081;21649.134034638635;20929;21184.788152118475;21237.725736455784;21446.463838404048;21446.463838404048;5230.163173892178;5561.416051314614;5562.610617256773;5567.359753628344;5595.300587426572;3983.183447393277;5215.791368345262;5447.210154527591;5823.155642431845;6248.812535623939;5622.859428514299;5840.8026354597205;6135.2024236849375;6249.3438188990185;6278.748850045993;5203.323567936144;5922.526197904179;6125.877482450326;6235.9376406235815;6265.436110750009;5465.824847657733;5865.941340586583;6030.185924900126;6094.664793436359;6129.417705317987;13850.722985540333;17696;21766.782332176794;26022.73977260241;26132.608010879852;2194.308792730285;2329.906803727849;2419.7822196002267;2497.825152239344;2773.55623100303;9942.701718948443;10058.849117263248;10265.743356416075;10638;10697.83953240702;1801.3875282403915;1820.3537744100918;1825.6439994201137;1859.8140185981429;1891.3758459708263;120178.39910800477;122077.99999999911;123599.38200308941;123733;125345;11933.70165745846;12019.819702704466;12060.035197184205;12105.213161144497;12165.817512737316;15415.46045888411;15592.688146237011;15751.369945202063;15771.29029193689;15780;8966.237869781142;9396.154346108882;9434.245260379153;9442.669506567374;9444.291678124167;9427.387219830689;9490.525473726286;9509.381890177116;9524.809503809885;9591.568379422943;4019.517657881073;4783.3497443381975;4863.513648635108;4877.536738978292;4908.460069392364;2015.4659015360942;2078.553111081125;2131.8187954024083;2181.8363622728357;2181.879996600202;913.4108500017452;995.5669283861398;1077.7305673581604;1099.9560017599367;1100.9119270458343;20767.376978690663;21348.89325553362;21481.82153870731;21609;21752;998.256299057207;1008.3294609085023;1014.1075853249093;1041.193075366597;1088.6026600290995;11271.436428178722;11350.54597816078;11635.709107272216;11695.941520292514;11697.473613687405;644606;660384;666994;667815;671167;117388;142394;142498;143515;145614;890.172139909877;1028.573142146016;1028.7325295423095;1040.557762950743;1056.4664844253602;18424.907875460536;18575.142485751316;18904.338348157748;18981.050947452848;19040.523986899883;43708.78145609252;56380;56482.15276770934;57087.43106560132;58009;83594.5820270919;83828;86538.56730716306;87012;87921.56039219763;7074.893876591958;8581.399302048796;8683.956580217058;8765.16730910588;8793.29653627721;9242.445453272825;10684.198685098494;12736.044796640474;13260.138091024053;13504.25726585008;7544.886826697713;9730.708078757649;10037.849432258376;11498.827517587075;11614.941925290319;11285.43572821372;11558.653240402802;11677;11810.232334898204;11879.109066820196;11315.660530184108;11550;11622.88377116218;11679.824802628138;11986.820197696867;8520.275776559061;8523.147685231428;8582.141785821368;8604.440711353742;8815.162559556831;8668.133186681282;9661.758456038655;10838;11630.6510804676;11699.356535390636 16:59:16 INFO - PROCESS | 1674 | |3;mootools.html;1592.2595992863316;1598.7122317982762;1873.840723538499;1978.7922268161851;2040.7245021922035;8125.674973001072;8777.60500777465;8921.866172007418;9109.954450227757;9139.908600913988;8816.338774591915;8824.558772061404;8929.419587726794;8932.508712020835;8933.374663773538;2217.268301460514;2225.8219342452644;2287.7254729432493;2530.367408147963;2535.733747956466;2516.5721827289312;2516.7483251674776;2563.371973866396;2574.124797568826;2575.381908341994;2516.018752686454;2538.4669219463935;2571.7813985811226;2579.6775403074616;2583.806214533908;2507.210228777938;2510.1214574898822;2533;2568.87155642219;2571.1772232885482;2528.3047162030407;2561.398071453207;2566.7304932981956;2568.768810807018;2572.536943350196;9067.138621830916;9072.591733371948;9135.995040545535;9156.496392698398;9163.725088247364;5616.410276920946;5773.134029895507;5806.854828629318;5817.301923769132;5824.88350232993;3421.2815308785184;3498.842552085137;3702.7222958278235;3724.646158614927;3754.887353379403;1063.2344711807486;1068.8456467015606;1080.692002779212;1082.220801023262;1084.3819023156805;12137.21108127969;12336.568220112253;12387.380630968415;12396.946259567947;12410.751784964341;4072;4928.186849169847;4967.528084831935;5074.594032477393;5091.949080509222;10445.059944605022;10507;10514.737131571772;10525.000124988113;10544;5591.832245032656;5605.355384130877;5679.6876171810945;5802.593818432669;5809.419058094157;4621.0295837873755;5034.395872495324;5136.486351364833;5144.408393034849;5159.896802063938;3522.735794815399;3709.350863598859;4232.640225580799;4255.553166917491;4369.344598310216;1135.7047167736448;1235.3452670084869;1263.6082814327588;1387.0775934003775;1429.756941319978;871.9564021798884;930.9441433514011;956.8469044952774;979.2361957673027;988.7330420786348;5090.974545127251;5735.99620066495;5797.623154494944;5968.1644569760265;6154.476869466145;466.62902992121343;470.9058188362341;471.5025647941386;481.4295060353492;489.3516091179131;4075.5924407559005;4093.1813637272667;4100.1184745279315;4147.149834283965;4160.54234034256;10733.51699173539;11053.834192486958;11110.388928608843;11144.275622084539;11169.888301117047;10679.305845120043;10702.518386672618;10964.396958167217;10977.506012229469;11027.17296202772;7342.926570734225;8570.528620925908;8571.699990500303;8612.913870861337;8660.82678346417;5700.486956173964;5964.194833697396;5978.521718262442;5984.910226346521;6072.696365181811;9812.362196457207;9826.213902887896;9832.360896541702;9999.900001000187;10064.245181611555;9651.565679544297;9915.900840991786;9943.751406214902;10039.598416063276;10385.896141038493;7098.219195888345;7518.360939320219;7756.767296981099;7822.374210063067;7925.167857375123;8265.132161122996;8583.785405364666;8602.698905538276;8609.784755381166;8639.222469977733;6864.21061577925;7616.200298968529;7703.653335600024;7739.729109481141;7809.960950195213;6185.226846644169;7311.341979221896;7557.584332861746;7597.354224890946;7632.69469221225;6098.634081955097;6156.692165391623;6255.906161407492;7262.346388825031;7278.745243916437;4945.727984960861;4980.477049909852;5032.345795046621;5043.420006699276;5050.570701490415;4989.675671081368;5043.142665746906;5051.848444546669;5157.458466860926;5211.244369566316 16:59:16 INFO - PROCESS | 1674 | |4;prototype.html;320.92458272305987;335.31260915123994;341.7747375658265;342.56494252299586;343.14556753683337;6048.76000419914;6493.285738568754;6765.898511522319;6880.552764070332;6950.200726916406;6975.825604359894;6992.930070699292;7035.869038277969;7078.85842283154;7084.397826184781;5155.432902380754;5166.612504062192;5170.965806838647;5190.987757387302;5202.219667049954;5150.9742451287875;5160.638755287131;5177.456367081459;5190.584753219752;5197.220416937471;5108.923366149511;5113.002964421939;5137.023965446572;5144.948550514484;5150.639455238135;3885.7862817545024;4942.481039490837;4950.87622809429;5120.129577971735;5125.282460455539;4171.10321280926;4176.394422808706;4192.727472714264;4201.571465701676;4207.768572728499;6566.507511936624;6588.538802283842;6589.0445885346835;6598.967005164992;6609.834754131137;5858.355580886142;5869.647821130746;5896.64620122794;5897.439743224387;5900.232969713953;7282.490225684204;7289.052423185005;7293.197748247689;7304.890426643605;7306.890396644055;4561.6806823522365;4706.5293470653005;4716.716996980193;4726.692764970266;4726.787294571753;5893.764249430061;7717.807054823618;7773.650185741599;7838.8432231355055;7854;4790.209615413488;4801.927971080437;4806.2310030394965;4819.204831202883;4825.565699087099;4897.338859254026;4905.552861905747;4906.558409743069;4913.533214344631;4932.112219800399;4211.241976444208;5558.055130627803;5747.39652336507;5871.911921321183;5901.026330655393;7167.498275120795;7367.742129025459;7423.183449820515;7437.330640242404;7498.775036748906;1671.648953719708;1702.446704820938;1702.5488245614922;1708.086173896959;1710.880238383326;927.2072378116613;1012.9746756331151;1055.0082922053398;1063.6862125672944;1075.4676435164488;6865.41643960259;6973.4072603829245;7008.983697363854;7033.542819716702;7068;7736.071671399468;7751.806204844924;7768.184340644264;7773.766786996399;7803.843923121619;6111.51107911366;6625.4037136657935;7025.367716905503;7029.929700702927;7042;3971.4241434991764;4081.6326530612387;4111.9177616447505;4113.552436300396;4124.7731374774075;8013.559254240956;8069.677212911535;8089.595520223966;8097.554634495042;8107.067687215927;7956.403269754792;7959.641816118288;7964.323032542299;7984.720534781371;8007.039155301285;8063.27430531255;8079.313258372987;8081.595920204084;8098.595070246464;8106.513609183467;6181.96909015452;7446.292602202782;7707.576083315472;7727.459077864495;7750.379969602305;7522.849543009219;7554.546727196166;7575.583342916192;7579.62101894892;7592.126905405728;8033.397495187767;8062.234087761653;8064.475809072392;8067.596620168851;8089.271965522896;4824.855254342376;4825.300331451849;4834.20235661126;4853.830115945925;4886.486918873609;6177.7026824367385;7367.963160184379;7685.346745526693;7697.961510192413;7745.728899488491;7355.374793142642;7406.1482929461645;7407.740729074457;7412.776891813006;7414.740484083031;7397.704091836482;7421.183669796426;7424.960505529122;7444.627768611439;7472.663730132266;7143.428525717826;7146.749863754743;7241.312075352833;7257.346838784323;7270.454715896435;7359.484836061424;7421.666025028994;7425.925740742523;7438;7459.254074592497;6989.930100698928;7181.784546463615;7384.815379615553;7394.445416593884;7423.925760742323 16:59:16 INFO - PROCESS | 1674 | |5;yui.html;678.5385937562455;720.7045111504284;764.3808515102763;787.9921200787991;788.9368850491959;15452.07287562747;15608.375664973388;15621.84378156218;15622.21888905553;15650.217489125542;11987.041036717064;13135.211887286769;14452.494162704308;14484.710305793878;14491.92754036231;785.6425326476468;812.9105798362175;870.2081106193365;943.0192599696342;961.1877963121186;783.9059312882462;954.2127744610689;954.7851733360008;956.086936975187;956.2493442647523;947.7488465556598;988.7626969527298;989.9752506187331;990.8761404824397;992.5583115513599;834.4784509681449;953.5184731710476;953.8330792111423;966.5505539923969;989.945552994585;616.9444749972524;723.4140346319446;747.3796748698567;749.2320371619134;749.4491548711693;13333.133346332457;13373.130746501543;13629.727405451835;13697.315134243248;13710.725785484234;11497.885021149765;11679.357635330054;11763.470643821049;11891.464884080237;12105.576304829288;9483.620655173785;9529.237660987104;9774.755631109208;9778.951105244429;9787.826086956522;3445.2248244144866;3477.009052420048;3502.3345564342694;3510.4558793387064;3563.020169453421;70040.6497967512;77123.84314235291;78224.60887695583;78768;83775;9556;9593.28050396223;9724.611015559298;10299.815521215007;10305.84541231882;20865.478363041046;21469.248576299753;21527.031283592274;21592.244271450425;21666.56666866654;7414.814629634302;7514.924850751532;7517.323440890346;7555.73554925575;7727.38180945523;4177.811998460076;4237.957620423756;4286.121345124242;4329.826806927751;4335.263005289108;3719.423489359154;3743.9251214975548;3778.7165962552917;3808.1050953026015;3812.313783518993;685.4345165238599;686;688.0539258519535;691.4641153106382;693.2893783871572;509.6789022915539;545.2176127257399;546.2434528178501;568.9829305120853;605.3190161068798;8243.752687419386;8429.157084291523;8444.324454043663;8589.742307730778;8733;593.1636392686291;603.1435361786274;617.2931992868141;620.6462316479564;625.9499240060784;3916.74541154824;3960.881173564798;3978;4012.3981402789814;4196.664266858644;89908.6513702295;91454;91741;96312.55531167038;96921;67126;76289;80835.7874631881;81278.18721812706;82293.17706822856;65984.67007664932;70739;71494.64252678704;71535;72339.91490127653;6775.424088952297;8265.297449716842;8347.45741526823;8425.368097392597;8604.182602652738;47567.286490701976;48818.75590622024;49552.752236238586;49788.502114979834;51133.48866511287;66775;66806.66596666985;67636.6472670534;69910.65044674744;70280.29719702738;11136.38749868765;11233.494492747683;11239.66281011571;11468.885311147116;11533.077353811506;12116.818247726114;12179.634610961686;12314.384280786104;12488;12557.811632825698;11159.553617855196;11646.94176529112;11796.469158888041;11893.989010933821;11940.223885447418;11208.215424920178;11683.415829208336;11704.765904682028;11794.76410471803;12092.516299348279;9695.884973228169;11640.417979101181;11725.824112638147;12038.337891416057;12140.696482588006;9940.304178707422;10001;10188.745281368025;10501.212409069198;10582.259241853304;8737.825243495221;9712.02879712023;10017.449040302561;10054.497275136067;10070.546825393021 16:59:16 INFO - PROCESS | 1674 | __end_tp_report 16:59:16 INFO - PROCESS | 1674 | __start_cc_report 16:59:16 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,392 16:59:16 INFO - PROCESS | 1674 | __end_cc_report 16:59:16 INFO - PROCESS | 1674 | __startTimestamp1467071956637__endTimestamp 16:59:16 INFO - PROCESS | 1674 | 16:59:16 INFO - PROCESS | 1674 | ------- Summary: start ------- 16:59:16 INFO - PROCESS | 1674 | Number of tests: 6 16:59:16 INFO - PROCESS | 1674 | 16:59:16 INFO - PROCESS | 1674 | [#0] dojo.html Cycles:165 Average:5920.18 Median:6180.23 stddev:688.49 (11.1%) stddev-sans-first:667.49 16:59:16 INFO - PROCESS | 1674 | Values: 3665.4 3693.2 3718.0 3733.7 3745.1 6002.6 6120.6 6124.2 6174.0 6176.7 4997.6 6085.3 6137.7 6169.0 6180.2 5450.9 5502.2 5543.3 5572.4 5628.5 5421.8 5422.4 5506.9 5511.0 5883.5 5040.8 5542.7 5564.2 5566.8 5567.7 5552.1 5567.6 5571.0 5582.9 5598.4 5328.4 5356.5 5422.4 5465.5 5467.2 4389.7 5990.7 6011.6 6033.0 6062.5 6339.6 6403.7 6410.1 6413.4 6416.9 6326.5 6381.9 6435.5 6497.8 6507.0 5103.8 6163.8 6170.7 6183.1 6201.6 6408.7 6578.3 6607.2 6624.8 6635.4 6260.2 6302.1 6314.5 6335.3 6355.9 6378.2 6384.5 6403.3 6412.2 6455.3 6208.3 6320.1 6326.2 6327.7 6340.1 6320.1 6382.9 6385.2 6390.4 6399.6 5123.0 5160.9 5162.1 5190.9 5195.4 4581.1 4625.0 4679.1 4699.9 4732.7 4732.8 4819.9 6073.9 6120.3 6163.0 6447.5 6458.2 6473.0 6482.5 6501.7 5234.7 5242.3 6158.7 6202.1 6223.0 4273.0 4728.7 5662.4 5675.7 5683.4 6706.8 6732.0 6732.1 6737.4 6737.5 5301.3 5996.9 6021.7 6472.9 6564.3 6070.6 6777.3 6792.7 6813.6 6816.7 5363.0 6435.8 6438.9 6444.7 6493.6 6326.6 6456.3 6518.7 6569.2 6575.5 6286.3 6300.9 6330.0 6343.7 6372.6 5045.9 6177.4 6248.2 6274.6 6302.5 5093.8 5236.8 5910.7 6129.9 6202.9 6266.6 6282.3 6288.5 6290.9 6326.1 6097.8 6219.2 6241.6 6245.9 6251.7 16:59:16 INFO - PROCESS | 1674 | 16:59:16 INFO - PROCESS | 1674 | [#1] ext.html Cycles:180 Average:62306.90 Median:38507.40 stddev:138198.30 (358.9%) stddev-sans-first:138508.18 16:59:16 INFO - PROCESS | 1674 | Values: 545.5 562.8 580.5 580.5 612.5 38738.4 39435.6 39981.8 40103.8 40270.2 41208.8 41259.8 41472.6 42125.6 42190.6 9628.9 9787.5 9804.8 9821.0 9871.4 9697.8 9907.7 9937.9 9945.3 9958.0 9842.4 9873.9 9879.2 9899.6 9964.6 9824.5 9854.8 9886.5 9899.6 9909.5 9725.8 9762.4 9819.7 9841.6 9882.8 34118.1 40138.6 40632.6 41036.6 41043.4 3123.9 3258.5 3272.7 3284.3 3449.6 21827.5 26818.3 27146.2 27458.9 27657.4 2665.5 2686.8 2726.7 2739.2 2801.5 245130.0 269315.3 294202.0 317117.0 320529.0 35217.6 35269.3 35324.8 38068.0 38636.4 37632.0 37644.0 37682.8 37740.1 38112.0 16490.0 16669.6 16683.0 16714.7 16718.7 13892.7 13968.8 14147.8 14149.0 14175.8 8207.2 8240.8 8244.2 8477.2 8560.1 3606.5 3623.1 3636.0 3651.1 3657.0 961.1 1052.8 1135.8 1148.3 1173.1 30297.8 30440.7 30555.8 30930.0 31244.5 1185.9 1213.1 1229.6 1238.2 1308.6 13697.9 15457.1 15691.4 15691.8 15796.8 556381.0 596290.0 613014.0 670431.0 676657.0 62386.4 62849.4 62877.7 62881.0 63267.1 1298.3 1533.3 1547.5 1553.8 1561.4 29527.3 29964.9 30083.5 30575.0 30734.0 52271.2 53098.5 53132.5 53358.7 53489.0 496972.0 580084.0 583992.0 584829.0 585279.0 26091.2 27058.7 27243.5 27424.6 27491.5 46721.5 47483.5 48094.5 48802.5 48938.3 38270.0 39474.0 39538.6 39854.2 40161.2 38482.8 38532.0 38625.2 39122.6 39301.0 38633.8 38847.6 39158.8 40326.0 40349.6 26473.6 30369.7 32913.8 33137.5 33302.0 25137.6 25199.7 25417.9 25460.9 25516.4 16:59:16 INFO - PROCESS | 1674 | 16:59:16 INFO - PROCESS | 1674 | [#2] jquery.html Cycles:180 Average:37548.16 Median:11974.31 stddev:110421.24 (922.2%) stddev-sans-first:110695.80 16:59:16 INFO - PROCESS | 1674 | Values: 416.3 418.0 420.8 426.2 431.3 20623.4 20918.8 21272.0 21345.4 21649.1 20929.0 21184.8 21237.7 21446.5 21446.5 5230.2 5561.4 5562.6 5567.4 5595.3 3983.2 5215.8 5447.2 5823.2 6248.8 5622.9 5840.8 6135.2 6249.3 6278.7 5203.3 5922.5 6125.9 6235.9 6265.4 5465.8 5865.9 6030.2 6094.7 6129.4 13850.7 17696.0 21766.8 26022.7 26132.6 2194.3 2329.9 2419.8 2497.8 2773.6 9942.7 10058.8 10265.7 10638.0 10697.8 1801.4 1820.4 1825.6 1859.8 1891.4 120178.4 122078.0 123599.4 123733.0 125345.0 11933.7 12019.8 12060.0 12105.2 12165.8 15415.5 15592.7 15751.4 15771.3 15780.0 8966.2 9396.2 9434.2 9442.7 9444.3 9427.4 9490.5 9509.4 9524.8 9591.6 4019.5 4783.3 4863.5 4877.5 4908.5 2015.5 2078.6 2131.8 2181.8 2181.9 913.4 995.6 1077.7 1100.0 1100.9 20767.4 21348.9 21481.8 21609.0 21752.0 998.3 1008.3 1014.1 1041.2 1088.6 11271.4 11350.5 11635.7 11695.9 11697.5 644606.0 660384.0 666994.0 667815.0 671167.0 117388.0 142394.0 142498.0 143515.0 145614.0 890.2 1028.6 1028.7 1040.6 1056.5 18424.9 18575.1 18904.3 18981.1 19040.5 43708.8 56380.0 56482.2 57087.4 58009.0 83594.6 83828.0 86538.6 87012.0 87921.6 7074.9 8581.4 8684.0 8765.2 8793.3 9242.4 10684.2 12736.0 13260.1 13504.3 7544.9 9730.7 10037.8 11498.8 11614.9 11285.4 11558.7 11677.0 11810.2 11879.1 11315.7 11550.0 11622.9 11679.8 11986.8 8520.3 8523.1 8582.1 8604.4 8815.2 8668.1 9661.8 10838.0 11630.7 11699.4 16:59:16 INFO - PROCESS | 1674 | 16:59:16 INFO - PROCESS | 1674 | [#3] mootools.html Cycles:180 Average:5845.12 Median:5033.37 stddev:3279.58 (65.2%) stddev-sans-first:3273.21 16:59:16 INFO - PROCESS | 1674 | Values: 1592.3 1598.7 1873.8 1978.8 2040.7 8125.7 8777.6 8921.9 9110.0 9139.9 8816.3 8824.6 8929.4 8932.5 8933.4 2217.3 2225.8 2287.7 2530.4 2535.7 2516.6 2516.7 2563.4 2574.1 2575.4 2516.0 2538.5 2571.8 2579.7 2583.8 2507.2 2510.1 2533.0 2568.9 2571.2 2528.3 2561.4 2566.7 2568.8 2572.5 9067.1 9072.6 9136.0 9156.5 9163.7 5616.4 5773.1 5806.9 5817.3 5824.9 3421.3 3498.8 3702.7 3724.6 3754.9 1063.2 1068.8 1080.7 1082.2 1084.4 12137.2 12336.6 12387.4 12396.9 12410.8 4072.0 4928.2 4967.5 5074.6 5091.9 10445.1 10507.0 10514.7 10525.0 10544.0 5591.8 5605.4 5679.7 5802.6 5809.4 4621.0 5034.4 5136.5 5144.4 5159.9 3522.7 3709.4 4232.6 4255.6 4369.3 1135.7 1235.3 1263.6 1387.1 1429.8 872.0 930.9 956.8 979.2 988.7 5091.0 5736.0 5797.6 5968.2 6154.5 466.6 470.9 471.5 481.4 489.4 4075.6 4093.2 4100.1 4147.1 4160.5 10733.5 11053.8 11110.4 11144.3 11169.9 10679.3 10702.5 10964.4 10977.5 11027.2 7342.9 8570.5 8571.7 8612.9 8660.8 5700.5 5964.2 5978.5 5984.9 6072.7 9812.4 9826.2 9832.4 9999.9 10064.2 9651.6 9915.9 9943.8 10039.6 10385.9 7098.2 7518.4 7756.8 7822.4 7925.2 8265.1 8583.8 8602.7 8609.8 8639.2 6864.2 7616.2 7703.7 7739.7 7810.0 6185.2 7311.3 7557.6 7597.4 7632.7 6098.6 6156.7 6255.9 7262.3 7278.7 4945.7 4980.5 5032.3 5043.4 5050.6 4989.7 5043.1 5051.8 5157.5 5211.2 16:59:16 INFO - PROCESS | 1674 | 16:59:16 INFO - PROCESS | 1674 | [#4] prototype.html Cycles:180 Average:6035.63 Median:6974.62 stddev:1963.77 (28.2%) stddev-sans-first:1921.86 16:59:16 INFO - PROCESS | 1674 | Values: 320.9 335.3 341.8 342.6 343.1 6048.8 6493.3 6765.9 6880.6 6950.2 6975.8 6992.9 7035.9 7078.9 7084.4 5155.4 5166.6 5171.0 5191.0 5202.2 5151.0 5160.6 5177.5 5190.6 5197.2 5108.9 5113.0 5137.0 5144.9 5150.6 3885.8 4942.5 4950.9 5120.1 5125.3 4171.1 4176.4 4192.7 4201.6 4207.8 6566.5 6588.5 6589.0 6599.0 6609.8 5858.4 5869.6 5896.6 5897.4 5900.2 7282.5 7289.1 7293.2 7304.9 7306.9 4561.7 4706.5 4716.7 4726.7 4726.8 5893.8 7717.8 7773.7 7838.8 7854.0 4790.2 4801.9 4806.2 4819.2 4825.6 4897.3 4905.6 4906.6 4913.5 4932.1 4211.2 5558.1 5747.4 5871.9 5901.0 7167.5 7367.7 7423.2 7437.3 7498.8 1671.6 1702.4 1702.5 1708.1 1710.9 927.2 1013.0 1055.0 1063.7 1075.5 6865.4 6973.4 7009.0 7033.5 7068.0 7736.1 7751.8 7768.2 7773.8 7803.8 6111.5 6625.4 7025.4 7029.9 7042.0 3971.4 4081.6 4111.9 4113.6 4124.8 8013.6 8069.7 8089.6 8097.6 8107.1 7956.4 7959.6 7964.3 7984.7 8007.0 8063.3 8079.3 8081.6 8098.6 8106.5 6182.0 7446.3 7707.6 7727.5 7750.4 7522.8 7554.5 7575.6 7579.6 7592.1 8033.4 8062.2 8064.5 8067.6 8089.3 4824.9 4825.3 4834.2 4853.8 4886.5 6177.7 7368.0 7685.3 7698.0 7745.7 7355.4 7406.1 7407.7 7412.8 7414.7 7397.7 7421.2 7425.0 7444.6 7472.7 7143.4 7146.7 7241.3 7257.3 7270.5 7359.5 7421.7 7425.9 7438.0 7459.3 6989.9 7181.8 7384.8 7394.4 7423.9 16:59:16 INFO - PROCESS | 1674 | 16:59:16 INFO - PROCESS | 1674 | [#5] yui.html Cycles:180 Average:18257.81 Median:617.12 stddev:25573.21 (4144.0%) stddev-sans-first:25610.88 16:59:16 INFO - PROCESS | 1674 | Values: 678.5 720.7 764.4 788.0 788.9 15452.1 15608.4 15621.8 15622.2 15650.2 11987.0 13135.2 14452.5 14484.7 14491.9 785.6 812.9 870.2 943.0 961.2 783.9 954.2 954.8 956.1 956.2 947.7 988.8 990.0 990.9 992.6 834.5 953.5 953.8 966.6 989.9 616.9 723.4 747.4 749.2 749.4 13333.1 13373.1 13629.7 13697.3 13710.7 11497.9 11679.4 11763.5 11891.5 12105.6 9483.6 9529.2 9774.8 9779.0 9787.8 3445.2 3477.0 3502.3 3510.5 3563.0 70040.6 77123.8 78224.6 78768.0 83775.0 9556.0 9593.3 9724.6 10299.8 10305.8 20865.5 21469.2 21527.0 21592.2 21666.6 7414.8 7514.9 7517.3 7555.7 7727.4 4177.8 4238.0 4286.1 4329.8 4335.3 3719.4 3743.9 3778.7 3808.1 3812.3 685.4 686.0 688.1 691.5 693.3 509.7 545.2 546.2 569.0 605.3 8243.8 8429.2 8444.3 8589.7 8733.0 593.2 603.1 617.3 620.6 625.9 3916.7 3960.9 3978.0 4012.4 4196.7 89908.7 91454.0 91741.0 96312.6 96921.0 67126.0 76289.0 80835.8 81278.2 82293.2 65984.7 70739.0 71494.6 71535.0 72339.9 6775.4 8265.3 8347.5 8425.4 8604.2 47567.3 48818.8 49552.8 49788.5 51133.5 66775.0 66806.7 67636.6 69910.7 70280.3 11136.4 11233.5 11239.7 11468.9 11533.1 12116.8 12179.6 12314.4 12488.0 12557.8 11159.6 11646.9 11796.5 11894.0 11940.2 11208.2 11683.4 11704.8 11794.8 12092.5 9695.9 11640.4 11725.8 12038.3 12140.7 9940.3 10001.0 10188.7 10501.2 10582.3 8737.8 9712.0 10017.4 10054.5 10070.5 16:59:16 INFO - PROCESS | 1674 | -------- Summary: end -------- 16:59:16 INFO - PROCESS | 1674 | 16:59:17 INFO - TEST-INFO | 1674: exit 0 16:59:17 INFO - TEST-OK | dromaeo_css | took 1109998ms 16:59:17 INFO - TEST-START | kraken 16:59:17 INFO - operating with platform_type : mac_ 16:59:17 INFO - Initialising browser for kraken test... 16:59:17 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/tmpbFD92T/profile http://localhost:49283/getInfo.html) 16:59:19 INFO - PROCESS | 1681 | __metrics Screen width/height:1600/1200 16:59:19 INFO - PROCESS | 1681 | colorDepth:24 16:59:19 INFO - PROCESS | 1681 | Browser inner width/height: 1024/689 16:59:19 INFO - PROCESS | 1681 | __metrics 16:59:19 ERROR - PROCESS | 1681 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 16:59:20 INFO - TEST-INFO | 1681: exit 0 16:59:20 INFO - Browser initialized. 16:59:20 INFO - Running cycle 1/1 for kraken test... 16:59:20 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/tmpbFD92T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:59:32 INFO - PROCESS | 1685 | RSS: Main: 171081728 16:59:32 INFO - PROCESS | 1685 | 16:59:34 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection) 16:59:35 INFO - PROCESS | 1685 | RSS: Main: 183828480 16:59:35 INFO - PROCESS | 1685 | 16:59:38 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-dft) 16:59:39 INFO - PROCESS | 1685 | RSS: Main: 192421888 16:59:39 INFO - PROCESS | 1685 | 16:59:42 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-fft) 16:59:43 INFO - PROCESS | 1685 | RSS: Main: 193892352 16:59:43 INFO - PROCESS | 1685 | 16:59:45 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator) 16:59:45 INFO - PROCESS | 1685 | RSS: Main: 195743744 16:59:45 INFO - PROCESS | 1685 | 16:59:47 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:59:48 INFO - PROCESS | 1685 | RSS: Main: 197672960 16:59:48 INFO - PROCESS | 1685 | 16:59:51 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom) 16:59:52 INFO - PROCESS | 1685 | RSS: Main: 198127616 16:59:52 INFO - PROCESS | 1685 | 16:59:54 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate) 16:59:55 INFO - PROCESS | 1685 | RSS: Main: 198266880 16:59:55 INFO - PROCESS | 1685 | 16:59:58 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial) 16:59:59 INFO - PROCESS | 1685 | RSS: Main: 198369280 16:59:59 INFO - PROCESS | 1685 | 17:00:00 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:00:01 INFO - PROCESS | 1685 | RSS: Main: 198004736 17:00:01 INFO - PROCESS | 1685 | 17:00:03 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:00:03 INFO - PROCESS | 1685 | RSS: Main: 198000640 17:00:03 INFO - PROCESS | 1685 | 17:00:05 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:00:06 INFO - PROCESS | 1685 | RSS: Main: 198668288 17:00:06 INFO - PROCESS | 1685 | 17:00:09 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:00:09 INFO - PROCESS | 1685 | RSS: Main: 198025216 17:00:09 INFO - PROCESS | 1685 | 17:00:12 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:00:13 INFO - PROCESS | 1685 | RSS: Main: 197918720 17:00:13 INFO - PROCESS | 1685 | 17:00:14 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49283/tests/kraken/driver.html?testName=ai-astar) 17:00:15 INFO - PROCESS | 1685 | RSS: Main: 199761920 17:00:15 INFO - PROCESS | 1685 | 17:00:15 INFO - PROCESS | 1685 | __start_tp_report 17:00:15 INFO - PROCESS | 1685 | _x_x_mozilla_page_load 17:00:15 INFO - PROCESS | 1685 | _x_x_mozilla_page_load_details 17:00:15 INFO - PROCESS | 1685 | |i|pagename|runs| 17:00:15 INFO - PROCESS | 1685 | |0;ai-astar;113;117;108;115;119;116;105;115;118;114 17:00:15 INFO - PROCESS | 1685 | |1;audio-beat-detection;150;127;180;157;148;168;167;126;162;135 17:00:15 INFO - PROCESS | 1685 | |2;audio-dft;231;182;250;272;208;275;272;195;191;203 17:00:15 INFO - PROCESS | 1685 | |3;audio-fft;66;84;103;171;84;79;68;67;125;79 17:00:15 INFO - PROCESS | 1685 | |4;audio-oscillator;79;81;121;78;80;80;117;83;76;116 17:00:15 INFO - PROCESS | 1685 | |5;imaging-gaussian-blur;87;85;87;85;84;102;133;97;133;127 17:00:15 INFO - PROCESS | 1685 | |6;imaging-darkroom;94;101;152;95;93;93;96;94;94;98 17:00:15 INFO - PROCESS | 1685 | |7;imaging-desaturate;125;149;111;91;89;91;89;91;100;128 17:00:15 INFO - PROCESS | 1685 | |8;json-parse-financial;59;61;64;63;64;62;55;97;86;88 17:00:15 INFO - PROCESS | 1685 | |9;json-stringify-tinderbox;62;66;65;73;66;68;71;67;66;64 17:00:15 INFO - PROCESS | 1685 | |10;stanford-crypto-aes;84;80;81;79;78;84;80;80;83;85 17:00:15 INFO - PROCESS | 1685 | |11;stanford-crypto-ccm;144;145;111;137;129;143;148;141;147;141 17:00:15 INFO - PROCESS | 1685 | |12;stanford-crypto-pbkdf2;164;164;164;162;166;168;161;171;165;172 17:00:15 INFO - PROCESS | 1685 | |13;stanford-crypto-sha256-iterative;70;66;69;69;68;66;76;88;96;74 17:00:15 INFO - PROCESS | 1685 | __end_tp_report 17:00:15 INFO - PROCESS | 1685 | __start_cc_report 17:00:15 INFO - PROCESS | 1685 | _x_x_mozilla_cycle_collect,1044 17:00:15 INFO - PROCESS | 1685 | __end_cc_report 17:00:15 INFO - PROCESS | 1685 | __startTimestamp1467072015175__endTimestamp 17:00:15 INFO - PROCESS | 1685 | 17:00:15 INFO - PROCESS | 1685 | ------- Summary: start ------- 17:00:15 INFO - PROCESS | 1685 | Number of tests: 14 17:00:15 INFO - PROCESS | 1685 | 17:00:15 INFO - PROCESS | 1685 | [#0] ai-astar Cycles:10 Average:114.00 Median:115.50 stddev:4.40 (3.8%) stddev-sans-first:4.65 17:00:15 INFO - PROCESS | 1685 | Values: 113.0 117.0 108.0 115.0 119.0 116.0 105.0 115.0 118.0 114.0 17:00:15 INFO - PROCESS | 1685 | 17:00:15 INFO - PROCESS | 1685 | [#1] audio-beat-detection Cycles:10 Average:152.00 Median:159.50 stddev:18.26 (11.4%) stddev-sans-first:19.35 17:00:15 INFO - PROCESS | 1685 | Values: 150.0 127.0 180.0 157.0 148.0 168.0 167.0 126.0 162.0 135.0 17:00:15 INFO - PROCESS | 1685 | 17:00:15 INFO - PROCESS | 1685 | [#2] audio-dft Cycles:10 Average:227.90 Median:240.50 stddev:36.78 (15.3%) stddev-sans-first:38.99 17:00:15 INFO - PROCESS | 1685 | Values: 231.0 182.0 250.0 272.0 208.0 275.0 272.0 195.0 191.0 203.0 17:00:15 INFO - PROCESS | 1685 | 17:00:15 INFO - PROCESS | 1685 | [#3] audio-fft Cycles:10 Average:92.60 Median:73.50 stddev:32.98 (44.9%) stddev-sans-first:33.55 17:00:15 INFO - PROCESS | 1685 | Values: 66.0 84.0 103.0 171.0 84.0 79.0 68.0 67.0 125.0 79.0 17:00:15 INFO - PROCESS | 1685 | 17:00:15 INFO - PROCESS | 1685 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:79.50 stddev:18.69 (23.5%) stddev-sans-first:19.31 17:00:15 INFO - PROCESS | 1685 | Values: 79.0 81.0 121.0 78.0 80.0 80.0 117.0 83.0 76.0 116.0 17:00:15 INFO - PROCESS | 1685 | 17:00:15 INFO - PROCESS | 1685 | [#5] imaging-gaussian-blur Cycles:10 Average:102.00 Median:85.00 stddev:20.88 (24.6%) stddev-sans-first:21.43 17:00:15 INFO - PROCESS | 1685 | Values: 87.0 85.0 87.0 85.0 84.0 102.0 133.0 97.0 133.0 127.0 17:00:15 INFO - PROCESS | 1685 | 17:00:15 INFO - PROCESS | 1685 | [#6] imaging-darkroom Cycles:10 Average:101.00 Median:94.00 stddev:18.09 (19.2%) stddev-sans-first:19.01 17:00:15 INFO - PROCESS | 1685 | Values: 94.0 101.0 152.0 95.0 93.0 93.0 96.0 94.0 94.0 98.0 17:00:15 INFO - PROCESS | 1685 | 17:00:15 INFO - PROCESS | 1685 | [#7] imaging-desaturate Cycles:10 Average:106.40 Median:89.00 stddev:21.10 (23.7%) stddev-sans-first:21.28 17:00:15 INFO - PROCESS | 1685 | Values: 125.0 149.0 111.0 91.0 89.0 91.0 89.0 91.0 100.0 128.0 17:00:15 INFO - PROCESS | 1685 | 17:00:15 INFO - PROCESS | 1685 | [#8] json-parse-financial Cycles:10 Average:69.90 Median:64.00 stddev:14.61 (22.8%) stddev-sans-first:14.95 17:00:15 INFO - PROCESS | 1685 | Values: 59.0 61.0 64.0 63.0 64.0 62.0 55.0 97.0 86.0 88.0 17:00:15 INFO - PROCESS | 1685 | 17:00:15 INFO - PROCESS | 1685 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:66.50 stddev:3.22 (4.8%) stddev-sans-first:2.92 17:00:15 INFO - PROCESS | 1685 | Values: 62.0 66.0 65.0 73.0 66.0 68.0 71.0 67.0 66.0 64.0 17:00:15 INFO - PROCESS | 1685 | 17:00:15 INFO - PROCESS | 1685 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:82.00 stddev:2.41 (2.9%) stddev-sans-first:2.37 17:00:15 INFO - PROCESS | 1685 | Values: 84.0 80.0 81.0 79.0 78.0 84.0 80.0 80.0 83.0 85.0 17:00:15 INFO - PROCESS | 1685 | 17:00:15 INFO - PROCESS | 1685 | [#11] stanford-crypto-ccm Cycles:10 Average:138.60 Median:143.50 stddev:11.14 (7.8%) stddev-sans-first:11.64 17:00:15 INFO - PROCESS | 1685 | Values: 144.0 145.0 111.0 137.0 129.0 143.0 148.0 141.0 147.0 141.0 17:00:15 INFO - PROCESS | 1685 | 17:00:15 INFO - PROCESS | 1685 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.70 Median:165.50 stddev:3.62 (2.2%) stddev-sans-first:3.79 17:00:15 INFO - PROCESS | 1685 | Values: 164.0 164.0 164.0 162.0 166.0 168.0 161.0 171.0 165.0 172.0 17:00:15 INFO - PROCESS | 1685 | 17:00:15 INFO - PROCESS | 1685 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.20 Median:72.00 stddev:10.08 (14.0%) stddev-sans-first:10.57 17:00:15 INFO - PROCESS | 1685 | Values: 70.0 66.0 69.0 69.0 68.0 66.0 76.0 88.0 96.0 74.0 17:00:15 INFO - PROCESS | 1685 | -------- Summary: end -------- 17:00:15 INFO - PROCESS | 1685 | 17:00:15 INFO - TEST-INFO | 1685: exit 0 17:00:15 INFO - TEST-OK | kraken | took 58722ms 17:00:15 INFO - SUITE-END | took 1168s 17:00:16 INFO - Completed test suite (00:19:29) 17:00:16 INFO - javascript benchmark 17:00:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3665.395209790385, 3693.169036966682, 3717.9814100929493, 3733.7199710021755, 3745.082454798575, 6002.579819412643, 6120.571559990803, 6124.173236613067, 6173.9999999999945, 6176.660283684396, 4997.625178111638, 6085.330613632497, 6137.72380242889, 6169.0437982112735, 6180.227471566043, 5450.945490545093, 5502.203479599084, 5543.25166102575, 5572.3870374258795, 5628.493435590796, 5421.780099477625, 5422.40353561108, 5506.862328441781, 5510.972445137789, 5883.529317654577, 5040.773165207556, 5542.722863856811, 5564.221009058735, 5566.832995010136, 5567.693776842272, 5552.083906155459, 5567.638103523258, 5571.0, 5582.944170558283, 5598.412166722476, 5328.360596728378, 5356.517913387775, 5422.43064478228, 5465.480779325958, 5467.20725494805, 4389.736615803062, 5990.73041713124, 6011.6393016418715, 6032.9698351508405, 6062.545309101835, 6339.587926784744, 6403.679816009181, 6410.134631824691, 6413.39072788089, 6416.903746443807, 6326.49388048955, 6381.936180638227, 6435.549511534195, 6497.805065848032, 6506.967465162691, 5103.821366252238, 6163.753449862, 6170.691465426711, 6183.134361189437, 6201.565890387675, 6408.743650254031, 6578.27638959714, 6607.174103237096, 6624.7681331154145, 6635.369639884203, 6260.186175797208, 6302.054691796267, 6314.463270621956, 6335.334789847092, 6355.936440635627, 6378.202724659418, 6384.457321127663, 6403.263624683128, 6412.23053233615, 6455.322191169954, 6208.317085120633, 6320.115183874262, 6326.177596912372, 6327.746890124436, 6340.144080549159, 6320.115183874262, 6382.904256436157, 6385.233771947396, 6390.4248617624635, 6399.616023038632, 5122.9743851281255, 5160.870978225499, 5162.096633089194, 5190.870228244248, 5195.376554813447, 4581.129585378767, 4625.0, 4679.087577922272, 4699.882502937454, 4732.692374995614, 4732.787024583902, 4819.903601927942, 6073.939260607337, 6120.294761999619, 6162.969185154046, 6447.451966582893, 6458.22501299847, 6473.0, 6482.481401487869, 6501.739930402731, 5234.743661521207, 5242.344706911636, 6158.692065396713, 6202.0696895465135, 6223.0354295084335, 4272.978635106804, 4728.699607607935, 5662.405447428043, 5675.659460432387, 5683.403242659544, 6706.83232919181, 6731.990201469819, 6732.057511948331, 6737.3599508046655, 6737.52837301394, 5301.310829592128, 5996.860596486654, 6021.675231449074, 6472.93980594111, 6564.310747371648, 6070.6357618543025, 6777.322267773183, 6792.694328755119, 6813.591184528944, 6816.693248803716, 5362.973185134206, 6435.774747883802, 6438.903416448663, 6444.742210311535, 6493.610383377012, 6326.588771729823, 6456.289808121197, 6518.73925042993, 6569.178852643419, 6575.473962082926, 6286.339934306832, 6300.905486417616, 6330.0, 6343.746250149942, 6372.55392122547, 5045.899082018265, 6177.351378105234, 6248.218972628421, 6274.560780745304, 6302.495800336053, 5093.796248150033, 5236.821715114069, 5910.674912879833, 6129.877402452015, 6202.906956395567, 6266.624002559861, 6282.277538083179, 6288.496920246461, 6290.937090629218, 6326.145970293951, 6097.7865774697675, 6219.222597175353, 6241.625502469867, 6245.937540624535, 6251.68741562911], "value": 5883.058554281337, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.5381784728611, 562.8480310316214, 580.5181699189671, 580.5297708855826, 612.5222326585265, 38738.41892371617, 39435.60564394362, 39981.8000909995, 40103.79948100259, 40270.1945961081, 41208.793956030255, 41259.793701031456, 41472.58527414725, 42125.57874421255, 42190.57809421913, 9628.903710962906, 9787.46168960707, 9804.754881127958, 9820.950895245514, 9871.40771553709, 9697.806043879118, 9907.702768916944, 9937.850932236022, 9945.254105942047, 9958.0, 9842.360246583985, 9873.851892221623, 9879.16027137694, 9899.604015839357, 9964.551595178198, 9824.508774561244, 9854.753631159207, 9886.505674716307, 9899.604015839357, 9909.504524773733, 9725.756856078655, 9762.36544624597, 9819.656312029116, 9841.557129929099, 9882.752931176707, 34118.14704632379, 40138.59861401407, 40632.59367406347, 41036.58963410358, 41043.38434923479, 3123.875044998197, 3258.462353711635, 3272.705456508902, 3284.293876816472, 3449.6205417404067, 21827.454313642287, 26818.329541761417, 27146.185614431597, 27458.90164393422, 27657.44685106307, 2665.453582015682, 2686.8043720544365, 2726.6864310604337, 2739.205630367191, 2801.453716525278, 245130.0, 269315.2671183217, 294202.0, 317117.0, 320529.0, 35217.64782352195, 35269.29461410809, 35324.82337588347, 38068.0, 38636.420453693216, 37632.0, 37644.0, 37682.81158594244, 37740.05649858776, 38112.0, 16490.010599364075, 16669.583260418345, 16683.0, 16714.6657066858, 16718.665626687398, 13892.652683682989, 13968.790468142986, 14147.787783183261, 14149.009569330254, 14175.78736318956, 8207.220314070153, 8240.793980150424, 8244.216799404046, 8477.152284771597, 8560.14398560139, 3606.4770608261656, 3623.0942264433893, 3635.981925060987, 3651.1419816343137, 3657.0, 961.1349785193242, 1052.768390953989, 1135.7785231879704, 1148.3397046698183, 1173.0908545877014, 30297.848510757747, 30440.695593043787, 30555.847220764197, 30930.0, 31244.531332030037, 1185.9445093866466, 1213.0659392267905, 1229.6126720083146, 1238.1704258146883, 1308.6008767326057, 13697.863021369858, 15457.072575645498, 15691.372345106069, 15691.764623530657, 15796.842031579537, 556381.0, 596290.0, 613014.0, 670431.0, 676657.0, 62386.376136238054, 62849.371506284355, 62877.68561157165, 62881.0, 63267.05099423512, 1298.2729671384054, 1533.2793587013862, 1547.5280039588033, 1553.766934959765, 1561.3988614383545, 29527.26181845471, 29964.850175748983, 30083.548746768378, 30575.0, 30734.0, 52271.21593176181, 53098.4690153109, 53132.46867531275, 53358.733206333716, 53489.0, 496972.0, 580084.0, 583992.0, 584829.0, 585279.0, 26091.217263482125, 27058.72941270562, 27243.455130897666, 27424.58863117015, 27491.450170996868, 46721.53278467308, 47483.52516474791, 48094.5190548104, 48802.511974881214, 48938.26592601185, 38270.0, 39474.01314967034, 39538.604613953496, 39854.202915940936, 40161.1967760649, 38482.80758596189, 38532.0, 38625.22749544937, 39122.608773911896, 39301.01747456336, 38633.80683096567, 38847.6115238844, 39158.80420597879, 40325.99185020281, 40349.59650403458, 26473.602895956963, 30369.696303036686, 32913.83543082269, 33137.50293745644, 33302.0, 25137.622935655614, 25199.74800251974, 25417.872910635328, 25460.872695636404, 25516.362090947874], "value": 18579.99190590451, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.3089271808798, 417.9791010449477, 420.8106352141537, 426.18811164731187, 431.26684636118586, 20623.38129856105, 20918.849463279512, 21272.0, 21345.35963921081, 21649.134034638635, 20929.0, 21184.788152118475, 21237.725736455784, 21446.463838404048, 21446.463838404048, 5230.163173892178, 5561.416051314614, 5562.610617256773, 5567.359753628344, 5595.300587426572, 3983.183447393277, 5215.791368345262, 5447.210154527591, 5823.155642431845, 6248.812535623939, 5622.859428514299, 5840.8026354597205, 6135.2024236849375, 6249.3438188990185, 6278.748850045993, 5203.323567936144, 5922.526197904179, 6125.877482450326, 6235.9376406235815, 6265.436110750009, 5465.824847657733, 5865.941340586583, 6030.185924900126, 6094.664793436359, 6129.417705317987, 13850.722985540333, 17696.0, 21766.782332176794, 26022.73977260241, 26132.608010879852, 2194.308792730285, 2329.906803727849, 2419.7822196002267, 2497.825152239344, 2773.55623100303, 9942.701718948443, 10058.849117263248, 10265.743356416075, 10638.0, 10697.83953240702, 1801.3875282403915, 1820.3537744100918, 1825.6439994201137, 1859.8140185981429, 1891.3758459708263, 120178.39910800477, 122077.99999999911, 123599.38200308941, 123733.0, 125345.0, 11933.70165745846, 12019.819702704466, 12060.035197184205, 12105.213161144497, 12165.817512737316, 15415.46045888411, 15592.688146237011, 15751.369945202063, 15771.29029193689, 15780.0, 8966.237869781142, 9396.154346108882, 9434.245260379153, 9442.669506567374, 9444.291678124167, 9427.387219830689, 9490.525473726286, 9509.381890177116, 9524.809503809885, 9591.568379422943, 4019.517657881073, 4783.3497443381975, 4863.513648635108, 4877.536738978292, 4908.460069392364, 2015.4659015360942, 2078.553111081125, 2131.8187954024083, 2181.8363622728357, 2181.879996600202, 913.4108500017452, 995.5669283861398, 1077.7305673581604, 1099.9560017599367, 1100.9119270458343, 20767.376978690663, 21348.89325553362, 21481.82153870731, 21609.0, 21752.0, 998.256299057207, 1008.3294609085023, 1014.1075853249093, 1041.193075366597, 1088.6026600290995, 11271.436428178722, 11350.54597816078, 11635.709107272216, 11695.941520292514, 11697.473613687405, 644606.0, 660384.0, 666994.0, 667815.0, 671167.0, 117388.0, 142394.0, 142498.0, 143515.0, 145614.0, 890.172139909877, 1028.573142146016, 1028.7325295423095, 1040.557762950743, 1056.4664844253602, 18424.907875460536, 18575.142485751316, 18904.338348157748, 18981.050947452848, 19040.523986899883, 43708.78145609252, 56380.0, 56482.15276770934, 57087.43106560132, 58009.0, 83594.5820270919, 83828.0, 86538.56730716306, 87012.0, 87921.56039219763, 7074.893876591958, 8581.399302048796, 8683.956580217058, 8765.16730910588, 8793.29653627721, 9242.445453272825, 10684.198685098494, 12736.044796640474, 13260.138091024053, 13504.25726585008, 7544.886826697713, 9730.708078757649, 10037.849432258376, 11498.827517587075, 11614.941925290319, 11285.43572821372, 11558.653240402802, 11677.0, 11810.232334898204, 11879.109066820196, 11315.660530184108, 11550.0, 11622.88377116218, 11679.824802628138, 11986.820197696867, 8520.275776559061, 8523.147685231428, 8582.141785821368, 8604.440711353742, 8815.162559556831, 8668.133186681282, 9661.758456038655, 10838.0, 11630.6510804676, 11699.356535390636], "value": 9870.865279854046, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1592.2595992863316, 1598.7122317982762, 1873.840723538499, 1978.7922268161851, 2040.7245021922035, 8125.674973001072, 8777.60500777465, 8921.866172007418, 9109.954450227757, 9139.908600913988, 8816.338774591915, 8824.558772061404, 8929.419587726794, 8932.508712020835, 8933.374663773538, 2217.268301460514, 2225.8219342452644, 2287.7254729432493, 2530.367408147963, 2535.733747956466, 2516.5721827289312, 2516.7483251674776, 2563.371973866396, 2574.124797568826, 2575.381908341994, 2516.018752686454, 2538.4669219463935, 2571.7813985811226, 2579.6775403074616, 2583.806214533908, 2507.210228777938, 2510.1214574898822, 2533.0, 2568.87155642219, 2571.1772232885482, 2528.3047162030407, 2561.398071453207, 2566.7304932981956, 2568.768810807018, 2572.536943350196, 9067.138621830916, 9072.591733371948, 9135.995040545535, 9156.496392698398, 9163.725088247364, 5616.410276920946, 5773.134029895507, 5806.854828629318, 5817.301923769132, 5824.88350232993, 3421.2815308785184, 3498.842552085137, 3702.7222958278235, 3724.646158614927, 3754.887353379403, 1063.2344711807486, 1068.8456467015606, 1080.692002779212, 1082.220801023262, 1084.3819023156805, 12137.21108127969, 12336.568220112253, 12387.380630968415, 12396.946259567947, 12410.751784964341, 4072.0, 4928.186849169847, 4967.528084831935, 5074.594032477393, 5091.949080509222, 10445.059944605022, 10507.0, 10514.737131571772, 10525.000124988113, 10544.0, 5591.832245032656, 5605.355384130877, 5679.6876171810945, 5802.593818432669, 5809.419058094157, 4621.0295837873755, 5034.395872495324, 5136.486351364833, 5144.408393034849, 5159.896802063938, 3522.735794815399, 3709.350863598859, 4232.640225580799, 4255.553166917491, 4369.344598310216, 1135.7047167736448, 1235.3452670084869, 1263.6082814327588, 1387.0775934003775, 1429.756941319978, 871.9564021798884, 930.9441433514011, 956.8469044952774, 979.2361957673027, 988.7330420786348, 5090.974545127251, 5735.99620066495, 5797.623154494944, 5968.1644569760265, 6154.476869466145, 466.62902992121343, 470.9058188362341, 471.5025647941386, 481.4295060353492, 489.3516091179131, 4075.5924407559005, 4093.1813637272667, 4100.1184745279315, 4147.149834283965, 4160.54234034256, 10733.51699173539, 11053.834192486958, 11110.388928608843, 11144.275622084539, 11169.888301117047, 10679.305845120043, 10702.518386672618, 10964.396958167217, 10977.506012229469, 11027.17296202772, 7342.926570734225, 8570.528620925908, 8571.699990500303, 8612.913870861337, 8660.82678346417, 5700.486956173964, 5964.194833697396, 5978.521718262442, 5984.910226346521, 6072.696365181811, 9812.362196457207, 9826.213902887896, 9832.360896541702, 9999.900001000187, 10064.245181611555, 9651.565679544297, 9915.900840991786, 9943.751406214902, 10039.598416063276, 10385.896141038493, 7098.219195888345, 7518.360939320219, 7756.767296981099, 7822.374210063067, 7925.167857375123, 8265.132161122996, 8583.785405364666, 8602.698905538276, 8609.784755381166, 8639.222469977733, 6864.21061577925, 7616.200298968529, 7703.653335600024, 7739.729109481141, 7809.960950195213, 6185.226846644169, 7311.341979221896, 7557.584332861746, 7597.354224890946, 7632.69469221225, 6098.634081955097, 6156.692165391623, 6255.906161407492, 7262.346388825031, 7278.745243916437, 4945.727984960861, 4980.477049909852, 5032.345795046621, 5043.420006699276, 5050.570701490415, 4989.675671081368, 5043.142665746906, 5051.848444546669, 5157.458466860926, 5211.244369566316], "value": 4644.564635792225, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.92458272305987, 335.31260915123994, 341.7747375658265, 342.56494252299586, 343.14556753683337, 6048.76000419914, 6493.285738568754, 6765.898511522319, 6880.552764070332, 6950.200726916406, 6975.825604359894, 6992.930070699292, 7035.869038277969, 7078.85842283154, 7084.397826184781, 5155.432902380754, 5166.612504062192, 5170.965806838647, 5190.987757387302, 5202.219667049954, 5150.9742451287875, 5160.638755287131, 5177.456367081459, 5190.584753219752, 5197.220416937471, 5108.923366149511, 5113.002964421939, 5137.023965446572, 5144.948550514484, 5150.639455238135, 3885.7862817545024, 4942.481039490837, 4950.87622809429, 5120.129577971735, 5125.282460455539, 4171.10321280926, 4176.394422808706, 4192.727472714264, 4201.571465701676, 4207.768572728499, 6566.507511936624, 6588.538802283842, 6589.0445885346835, 6598.967005164992, 6609.834754131137, 5858.355580886142, 5869.647821130746, 5896.64620122794, 5897.439743224387, 5900.232969713953, 7282.490225684204, 7289.052423185005, 7293.197748247689, 7304.890426643605, 7306.890396644055, 4561.6806823522365, 4706.5293470653005, 4716.716996980193, 4726.692764970266, 4726.787294571753, 5893.764249430061, 7717.807054823618, 7773.650185741599, 7838.8432231355055, 7854.0, 4790.209615413488, 4801.927971080437, 4806.2310030394965, 4819.204831202883, 4825.565699087099, 4897.338859254026, 4905.552861905747, 4906.558409743069, 4913.533214344631, 4932.112219800399, 4211.241976444208, 5558.055130627803, 5747.39652336507, 5871.911921321183, 5901.026330655393, 7167.498275120795, 7367.742129025459, 7423.183449820515, 7437.330640242404, 7498.775036748906, 1671.648953719708, 1702.446704820938, 1702.5488245614922, 1708.086173896959, 1710.880238383326, 927.2072378116613, 1012.9746756331151, 1055.0082922053398, 1063.6862125672944, 1075.4676435164488, 6865.41643960259, 6973.4072603829245, 7008.983697363854, 7033.542819716702, 7068.0, 7736.071671399468, 7751.806204844924, 7768.184340644264, 7773.766786996399, 7803.843923121619, 6111.51107911366, 6625.4037136657935, 7025.367716905503, 7029.929700702927, 7042.0, 3971.4241434991764, 4081.6326530612387, 4111.9177616447505, 4113.552436300396, 4124.7731374774075, 8013.559254240956, 8069.677212911535, 8089.595520223966, 8097.554634495042, 8107.067687215927, 7956.403269754792, 7959.641816118288, 7964.323032542299, 7984.720534781371, 8007.039155301285, 8063.27430531255, 8079.313258372987, 8081.595920204084, 8098.595070246464, 8106.513609183467, 6181.96909015452, 7446.292602202782, 7707.576083315472, 7727.459077864495, 7750.379969602305, 7522.849543009219, 7554.546727196166, 7575.583342916192, 7579.62101894892, 7592.126905405728, 8033.397495187767, 8062.234087761653, 8064.475809072392, 8067.596620168851, 8089.271965522896, 4824.855254342376, 4825.300331451849, 4834.20235661126, 4853.830115945925, 4886.486918873609, 6177.7026824367385, 7367.963160184379, 7685.346745526693, 7697.961510192413, 7745.728899488491, 7355.374793142642, 7406.1482929461645, 7407.740729074457, 7412.776891813006, 7414.740484083031, 7397.704091836482, 7421.183669796426, 7424.960505529122, 7444.627768611439, 7472.663730132266, 7143.428525717826, 7146.749863754743, 7241.312075352833, 7257.346838784323, 7270.454715896435, 7359.484836061424, 7421.666025028994, 7425.925740742523, 7438.0, 7459.254074592497, 6989.930100698928, 7181.784546463615, 7384.815379615553, 7394.445416593884, 7423.925760742323], "value": 5369.690048854396, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.5385937562455, 720.7045111504284, 764.3808515102763, 787.9921200787991, 788.9368850491959, 15452.07287562747, 15608.375664973388, 15621.84378156218, 15622.21888905553, 15650.217489125542, 11987.041036717064, 13135.211887286769, 14452.494162704308, 14484.710305793878, 14491.92754036231, 785.6425326476468, 812.9105798362175, 870.2081106193365, 943.0192599696342, 961.1877963121186, 783.9059312882462, 954.2127744610689, 954.7851733360008, 956.086936975187, 956.2493442647523, 947.7488465556598, 988.7626969527298, 989.9752506187331, 990.8761404824397, 992.5583115513599, 834.4784509681449, 953.5184731710476, 953.8330792111423, 966.5505539923969, 989.945552994585, 616.9444749972524, 723.4140346319446, 747.3796748698567, 749.2320371619134, 749.4491548711693, 13333.133346332457, 13373.130746501543, 13629.727405451835, 13697.315134243248, 13710.725785484234, 11497.885021149765, 11679.357635330054, 11763.470643821049, 11891.464884080237, 12105.576304829288, 9483.620655173785, 9529.237660987104, 9774.755631109208, 9778.951105244429, 9787.826086956522, 3445.2248244144866, 3477.009052420048, 3502.3345564342694, 3510.4558793387064, 3563.020169453421, 70040.6497967512, 77123.84314235291, 78224.60887695583, 78768.0, 83775.0, 9556.0, 9593.28050396223, 9724.611015559298, 10299.815521215007, 10305.84541231882, 20865.478363041046, 21469.248576299753, 21527.031283592274, 21592.244271450425, 21666.56666866654, 7414.814629634302, 7514.924850751532, 7517.323440890346, 7555.73554925575, 7727.38180945523, 4177.811998460076, 4237.957620423756, 4286.121345124242, 4329.826806927751, 4335.263005289108, 3719.423489359154, 3743.9251214975548, 3778.7165962552917, 3808.1050953026015, 3812.313783518993, 685.4345165238599, 686.0, 688.0539258519535, 691.4641153106382, 693.2893783871572, 509.6789022915539, 545.2176127257399, 546.2434528178501, 568.9829305120853, 605.3190161068798, 8243.752687419386, 8429.157084291523, 8444.324454043663, 8589.742307730778, 8733.0, 593.1636392686291, 603.1435361786274, 617.2931992868141, 620.6462316479564, 625.9499240060784, 3916.74541154824, 3960.881173564798, 3978.0, 4012.3981402789814, 4196.664266858644, 89908.6513702295, 91454.0, 91741.0, 96312.55531167038, 96921.0, 67126.0, 76289.0, 80835.7874631881, 81278.18721812706, 82293.17706822856, 65984.67007664932, 70739.0, 71494.64252678704, 71535.0, 72339.91490127653, 6775.424088952297, 8265.297449716842, 8347.45741526823, 8425.368097392597, 8604.182602652738, 47567.286490701976, 48818.75590622024, 49552.752236238586, 49788.502114979834, 51133.48866511287, 66775.0, 66806.66596666985, 67636.6472670534, 69910.65044674744, 70280.29719702738, 11136.38749868765, 11233.494492747683, 11239.66281011571, 11468.885311147116, 11533.077353811506, 12116.818247726114, 12179.634610961686, 12314.384280786104, 12488.0, 12557.811632825698, 11159.553617855196, 11646.94176529112, 11796.469158888041, 11893.989010933821, 11940.223885447418, 11208.215424920178, 11683.415829208336, 11704.765904682028, 11794.76410471803, 12092.516299348279, 9695.884973228169, 11640.417979101181, 11725.824112638147, 12038.337891416057, 12140.696482588006, 9940.304178707422, 10001.0, 10188.745281368025, 10501.212409069198, 10582.259241853304, 8737.825243495221, 9712.02879712023, 10017.449040302561, 10054.497275136067, 10070.546825393021], "value": 6967.330778634946, "unit": "score"}], "name": "dromaeo_css", "value": 7565.41937990645, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 108.0, 115.0, 119.0, 116.0, 105.0, 115.0, 118.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 127.0, 180.0, 157.0, 148.0, 168.0, 167.0, 126.0, 162.0, 135.0], "value": 152.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [231.0, 182.0, 250.0, 272.0, 208.0, 275.0, 272.0, 195.0, 191.0, 203.0], "value": 227.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 84.0, 103.0, 171.0, 84.0, 79.0, 68.0, 67.0, 125.0, 79.0], "value": 92.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 121.0, 78.0, 80.0, 80.0, 117.0, 83.0, 76.0, 116.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 85.0, 84.0, 102.0, 133.0, 97.0, 133.0, 127.0], "value": 102.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 101.0, 152.0, 95.0, 93.0, 93.0, 96.0, 94.0, 94.0, 98.0], "value": 101.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 149.0, 111.0, 91.0, 89.0, 91.0, 89.0, 91.0, 100.0, 128.0], "value": 106.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 64.0, 63.0, 64.0, 62.0, 55.0, 97.0, 86.0, 88.0], "value": 69.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 66.0, 65.0, 73.0, 66.0, 68.0, 71.0, 67.0, 66.0, 64.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 81.0, 79.0, 78.0, 84.0, 80.0, 80.0, 83.0, 85.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 145.0, 111.0, 137.0, 129.0, 143.0, 148.0, 141.0, 147.0, 141.0], "value": 138.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 164.0, 162.0, 166.0, 168.0, 161.0, 171.0, 165.0, 172.0], "value": 165.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 69.0, 69.0, 68.0, 66.0, 76.0, 88.0, 96.0, 74.0], "value": 74.2, "unit": "score"}], "name": "kraken", "value": 1583.6000000000001, "alertThreshold": 2.0}]} 17:00:16 INFO - Return code: 0 17:00:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:00:16 ERROR - # TBPL SUCCESS # 17:00:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:00:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:00:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:00:16 INFO - 2016-06-27 17:00:16.488 screenresolution[1690:10728] starting screenresolution argv=screenresolution get 17:00:16 INFO - 2016-06-27 17:00:16.490 screenresolution[1690:10728] Display 0: 1600x1200x32@60 17:00:16 INFO - 2016-06-27 17:00:16.496 screenresolution[1691:10731] starting screenresolution argv=screenresolution list 17:00:16 INFO - Available Modes on Display 0 17:00:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:00:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:00:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:00:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:00:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:00:16 INFO - Intel Iris: 17:00:16 INFO - Chipset Model: Intel Iris 17:00:16 INFO - Type: GPU 17:00:16 INFO - Bus: Built-In 17:00:16 INFO - VRAM (Dynamic, Max): 1536 MB 17:00:16 INFO - Vendor: Intel (0x8086) 17:00:16 INFO - Device ID: 0x0a2e 17:00:16 INFO - Revision ID: 0x0009 17:00:16 INFO - Displays: 17:00:16 INFO - Display: 17:00:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:00:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:00:16 INFO - Display Serial Number: 1600x1200 60 17:00:16 INFO - Main Display: Yes 17:00:16 INFO - Mirror: Off 17:00:16 INFO - Online: Yes 17:00:16 INFO - Rotation: Supported 17:00:16 INFO - Return code: 0 17:00:16 INFO - Running post-action listener: _resource_record_post_action 17:00:16 INFO - Running post-run listener: _resource_record_post_run 17:00:17 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 31042048; Write bytes: 498863616; Read time: 306; Write time: 1628 17:00:17 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 193409536; Write bytes: 189331456; Read time: 17744; Write time: 416 17:00:17 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 29256192; Write bytes: 299791872; Read time: 287; Write time: 1182 17:00:17 INFO - Running post-run listener: _upload_blobber_files 17:00:17 INFO - Blob upload gear active. 17:00:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:00:17 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 17:00:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:00:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:00:18 INFO - (blobuploader) - INFO - Open directory for files ... 17:00:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:00:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:00:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:00:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:00:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:00:18 INFO - (blobuploader) - INFO - Done attempting. 17:00:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:00:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:00:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:00:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:00:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:00:19 INFO - (blobuploader) - INFO - Done attempting. 17:00:19 INFO - (blobuploader) - INFO - Iteration through files over. 17:00:19 INFO - Return code: 0 17:00:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:00:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:00:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8a25351689da5ee7528e3270dd18bbe60b2184ab7d87d9098e88de5081f5c83d6b1a3eef12f47eea5ad2d0b906b640be23cc10826b4c709386dbb158ab49fd52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1668c92e7d1e18558e65e1fdf77fab6e46b5ef91efe0a82dad8568adb06c320a62138fdda1a1c5b25aeff3862ac886a2e7323ca0bee67feceb3381d687011b1f"} 17:00:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:00:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:00:19 INFO - Contents: 17:00:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8a25351689da5ee7528e3270dd18bbe60b2184ab7d87d9098e88de5081f5c83d6b1a3eef12f47eea5ad2d0b906b640be23cc10826b4c709386dbb158ab49fd52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1668c92e7d1e18558e65e1fdf77fab6e46b5ef91efe0a82dad8568adb06c320a62138fdda1a1c5b25aeff3862ac886a2e7323ca0bee67feceb3381d687011b1f"} 17:00:19 INFO - Running post-run listener: copy_logs_to_upload_dir 17:00:19 INFO - Copying logs to upload dir... 17:00:19 INFO - mkdir: /builds/slave/test/build/upload/logs 17:00:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.063070 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-06-27 17:00:19.897383) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 17:00:19.901020) ========= 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.iAvAx5pGWE/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.r78gllWsxb/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8a25351689da5ee7528e3270dd18bbe60b2184ab7d87d9098e88de5081f5c83d6b1a3eef12f47eea5ad2d0b906b640be23cc10826b4c709386dbb158ab49fd52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1668c92e7d1e18558e65e1fdf77fab6e46b5ef91efe0a82dad8568adb06c320a62138fdda1a1c5b25aeff3862ac886a2e7323ca0bee67feceb3381d687011b1f"} build_url:https://queue.taskcluster.net/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011114 build_url: 'https://queue.taskcluster.net/v1/task/P856YHohTYKOFNm_9E3ngg/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8a25351689da5ee7528e3270dd18bbe60b2184ab7d87d9098e88de5081f5c83d6b1a3eef12f47eea5ad2d0b906b640be23cc10826b4c709386dbb158ab49fd52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1668c92e7d1e18558e65e1fdf77fab6e46b5ef91efe0a82dad8568adb06c320a62138fdda1a1c5b25aeff3862ac886a2e7323ca0bee67feceb3381d687011b1f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 17:00:19.934367) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 17:00:19.934692) ========= 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.iAvAx5pGWE/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.r78gllWsxb/Listeners TMPDIR=/var/folders/s1/hcll5qd56kv3p0b9_8lpr4kw00000w/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.005327 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 17:00:19.985547) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 17:00:19.985863) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 17:00:19.986200) ========= ========= Total master_lag: 0.19 =========