builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0071 starttime: 1464443834.6 results: success (0) buildid: 20160528051133 builduid: 7503437525154ad183cd41cd16907ba0 revision: bfea62662298a8400d559abd40ec7d4d12fbd97d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 06:57:14.595347) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 06:57:14.595785) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 06:57:14.596073) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 06:57:14.646684) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 06:57:14.646968) ========= 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.rkKWUJifQ4/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.5hEmXgfcoP/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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-05-28 06:57:14-- 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% 72.4M=0s 2016-05-28 06:57:15 (72.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.613376 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 06:57:15.283894) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 06:57:15.284182) ========= 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.rkKWUJifQ4/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.5hEmXgfcoP/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.027903 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 06:57:15.344175) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-28 06:57:15.344481) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bfea62662298a8400d559abd40ec7d4d12fbd97d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bfea62662298a8400d559abd40ec7d4d12fbd97d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rkKWUJifQ4/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.5hEmXgfcoP/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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-05-28 06:57:15,421 truncating revision to first 12 chars 2016-05-28 06:57:15,421 Setting DEBUG logging. 2016-05-28 06:57:15,421 attempt 1/10 2016-05-28 06:57:15,421 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bfea62662298?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-28 06:57:16,535 unpacking tar archive at: mozilla-aurora-bfea62662298/testing/mozharness/ program finished with exit code 0 elapsedTime=1.364036 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-28 06:57:16.729262) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 06:57:16.729574) ========= script_repo_revision: bfea62662298a8400d559abd40ec7d4d12fbd97d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 06:57:16.729927) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 06:57:16.730202) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 06:57:16.746126) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2016-05-28 06:57:16.746390) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rkKWUJifQ4/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.5hEmXgfcoP/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 06:57:16 INFO - MultiFileLogger online at 20160528 06:57:16 in /builds/slave/test 06:57:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:57:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:57:16 INFO - {'append_to_log': False, 06:57:16 INFO - 'base_work_dir': '/builds/slave/test', 06:57:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:57:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:57:16 INFO - 'branch': 'Mozilla-Aurora', 06:57:16 INFO - 'buildbot_json_path': 'buildprops.json', 06:57:16 INFO - 'config_files': ('talos/mac_config.py',), 06:57:16 INFO - 'default_actions': ('clobber', 06:57:16 INFO - 'read-buildbot-config', 06:57:16 INFO - 'download-and-extract', 06:57:16 INFO - 'populate-webroot', 06:57:16 INFO - 'create-virtualenv', 06:57:16 INFO - 'install', 06:57:16 INFO - 'run-tests'), 06:57:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:57:16 INFO - 'download_minidump_stackwalk': True, 06:57:16 INFO - 'download_symbols': 'ondemand', 06:57:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:57:16 INFO - 'tooltool.py': '/tools/tooltool.py', 06:57:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:57:16 INFO - '/tools/misc-python/virtualenv.py')}, 06:57:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:57:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:57:16 INFO - 'installer_path': 'installer.exe', 06:57:16 INFO - 'log_level': 'info', 06:57:16 INFO - 'log_name': 'talos', 06:57:16 INFO - 'log_to_console': True, 06:57:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:57:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:57:16 INFO - 'opt_config_files': (), 06:57:16 INFO - 'pip_index': False, 06:57:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:57:16 INFO - 'cmd': ('bash', 06:57:16 INFO - '-c', 06:57:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:57:16 INFO - 'enabled': True, 06:57:16 INFO - 'halt_on_failure': False, 06:57:16 INFO - 'name': 'check_screen_resolution'},), 06:57:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:57:16 INFO - 'cmd': ('bash', 06:57:16 INFO - '-c', 06:57:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:57:16 INFO - 'enabled': True, 06:57:16 INFO - 'halt_on_failure': False, 06:57:16 INFO - 'name': 'check_screen_resolution'},), 06:57:16 INFO - 'run_cmd_checks_enabled': True, 06:57:16 INFO - 'sps_profile': False, 06:57:16 INFO - 'sps_profile_interval': 0, 06:57:16 INFO - 'suite': 'dromaeojs-e10s', 06:57:16 INFO - 'system_bits': '32', 06:57:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:57:16 INFO - 'title': 't-yosemite-r7-0071', 06:57:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:57:16 INFO - 'use_talos_json': True, 06:57:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:57:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:57:16 INFO - 'work_dir': 'build'} 06:57:16 INFO - ##### 06:57:16 INFO - ##### Running clobber step. 06:57:16 INFO - ##### 06:57:16 INFO - Running pre-action listener: _resource_record_pre_action 06:57:16 INFO - Running main action method: clobber 06:57:16 INFO - rmtree: /builds/slave/test/build 06:57:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:57:18 INFO - Running post-action listener: _resource_record_post_action 06:57:18 INFO - ##### 06:57:18 INFO - ##### Running read-buildbot-config step. 06:57:18 INFO - ##### 06:57:18 INFO - Running pre-action listener: _resource_record_pre_action 06:57:18 INFO - Running main action method: read_buildbot_config 06:57:18 INFO - Using buildbot properties: 06:57:18 INFO - { 06:57:18 INFO - "project": "", 06:57:18 INFO - "product": "firefox", 06:57:18 INFO - "script_repo_revision": "production", 06:57:18 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 06:57:18 INFO - "repository": "", 06:57:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 06:57:18 INFO - "buildid": "20160528051133", 06:57:18 INFO - "pgo_build": "False", 06:57:18 INFO - "basedir": "/builds/slave/test", 06:57:18 INFO - "buildnumber": 12, 06:57:18 INFO - "slavename": "t-yosemite-r7-0071", 06:57:18 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 06:57:18 INFO - "platform": "yosemite_r7", 06:57:18 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 06:57:18 INFO - "branch": "mozilla-aurora", 06:57:18 INFO - "repo_path": "releases/mozilla-aurora", 06:57:18 INFO - "revision": "bfea62662298a8400d559abd40ec7d4d12fbd97d", 06:57:18 INFO - "stage_platform": "macosx64", 06:57:18 INFO - "builduid": "7503437525154ad183cd41cd16907ba0", 06:57:18 INFO - "slavebuilddir": "test" 06:57:18 INFO - } 06:57:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg. 06:57:18 INFO - Running post-action listener: _resource_record_post_action 06:57:18 INFO - ##### 06:57:18 INFO - ##### Running download-and-extract step. 06:57:18 INFO - ##### 06:57:18 INFO - Running pre-action listener: _resource_record_pre_action 06:57:18 INFO - Running main action method: download_and_extract 06:57:18 INFO - mkdir: /builds/slave/test/build/tests 06:57: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')]} 06:57:18 INFO - https://queue.taskcluster.net/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:57:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 06:57:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 06:57:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 06:57:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json'}, attempt #1 06:57:37 INFO - Downloaded 1199 bytes. 06:57:37 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 06:57:37 INFO - Using the following test package requirements: 06:57:37 INFO - {u'common': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 06:57:37 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:57:37 INFO - u'firefox-48.0a2.en-US.mac.cppunittest.tests.zip'], 06:57:37 INFO - u'gtest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:57:37 INFO - u'firefox-48.0a2.en-US.mac.gtest.tests.zip'], 06:57:37 INFO - u'jittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:57:37 INFO - u'jsshell-mac.zip'], 06:57:37 INFO - u'mochitest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:57:37 INFO - u'firefox-48.0a2.en-US.mac.mochitest.tests.zip'], 06:57:37 INFO - u'mozbase': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 06:57:37 INFO - u'reftest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:57:37 INFO - u'firefox-48.0a2.en-US.mac.reftest.tests.zip'], 06:57:37 INFO - u'talos': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:57:37 INFO - u'firefox-48.0a2.en-US.mac.talos.tests.zip'], 06:57:37 INFO - u'web-platform': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:57:37 INFO - u'firefox-48.0a2.en-US.mac.web-platform.tests.zip'], 06:57:37 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:57:37 INFO - u'firefox-48.0a2.en-US.mac.xpcshell.tests.zip']} 06:57:37 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip'] for test suite category: common 06:57:37 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')]} 06:57:37 INFO - https://queue.taskcluster.net/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:57:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 06:57:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 06:57:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 06:57:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:57:39 INFO - Downloaded 18425596 bytes. 06:57:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:57:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:57:42 INFO - Return code: 0 06:57:42 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip', u'firefox-48.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 06:57:42 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')]} 06:57:42 INFO - https://queue.taskcluster.net/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:57:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 06:57:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 06:57:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 06:57:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:57:54 INFO - Downloaded 18425596 bytes. 06:57:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:57:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:57:58 INFO - Return code: 0 06:57:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:57:58 INFO - https://queue.taskcluster.net/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:57:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 06:57:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 06:57:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip 06:57:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip'}, attempt #1 06:57:59 INFO - Downloaded 10840145 bytes. 06:57:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:57:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 06:57:59 INFO - Return code: 0 06:57:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:57:59 INFO - https://queue.taskcluster.net/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 06:57:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 06:57:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 06:57:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg 06:57:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg'}, attempt #1 06:58:03 INFO - Downloaded 114140972 bytes. 06:58:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 06:58:03 INFO - mkdir: /builds/slave/test/properties 06:58:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:58:03 INFO - Writing to file /builds/slave/test/properties/build_url 06:58:03 INFO - Contents: 06:58:03 INFO - build_url:https://queue.taskcluster.net/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 06:58:04 INFO - Running post-action listener: _resource_record_post_action 06:58:04 INFO - Running post-action listener: set_extra_try_arguments 06:58:04 INFO - ##### 06:58:04 INFO - ##### Running populate-webroot step. 06:58:04 INFO - ##### 06:58:04 INFO - Running pre-action listener: _resource_record_pre_action 06:58:04 INFO - Running main action method: populate_webroot 06:58:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:58:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:58:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:58:05 INFO - '--tppagecycles', 06:58:05 INFO - '7'], 06:58:05 INFO - 'tests': ['tsvgm']}}, 06:58:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:58:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:58:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:58:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:58:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:58:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:58:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:05 INFO - 'talos_options': ['--disable-e10s'], 06:58:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:58:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:58:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:05 INFO - 'talos_options': ['--disable-e10s'], 06:58:05 INFO - 'tests': ['damp', 'tps']}, 06:58:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:05 INFO - 'tests': ['damp', 'tps']}, 06:58:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:58:05 INFO - 'tests': ['dromaeo_dom']}, 06:58:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:58:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:58:05 INFO - 'tests': ['a11yr', 06:58:05 INFO - 'ts_paint', 06:58:05 INFO - 'tpaint', 06:58:05 INFO - 'sessionrestore', 06:58:05 INFO - 'sessionrestore_no_auto_restore', 06:58:05 INFO - 'tabpaint']}, 06:58:05 INFO - 'other-e10s': {'tests': ['a11yr', 06:58:05 INFO - 'ts_paint', 06:58:05 INFO - 'tpaint', 06:58:05 INFO - 'sessionrestore', 06:58:05 INFO - 'sessionrestore_no_auto_restore', 06:58:05 INFO - 'tabpaint']}, 06:58:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:58:05 INFO - 'ts_paint', 06:58:05 INFO - 'tpaint', 06:58:05 INFO - 'sessionrestore', 06:58:05 INFO - 'sessionrestore_no_auto_restore', 06:58:05 INFO - 'tabpaint']}, 06:58:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:58:05 INFO - 'ts_paint', 06:58:05 INFO - 'tpaint', 06:58:05 INFO - 'sessionrestore', 06:58:05 INFO - 'sessionrestore_no_auto_restore', 06:58:05 INFO - 'tabpaint']}, 06:58:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:58:05 INFO - 'tests': ['a11yr', 06:58:05 INFO - 'ts_paint', 06:58:05 INFO - 'tpaint', 06:58:05 INFO - 'sessionrestore', 06:58:05 INFO - 'sessionrestore_no_auto_restore', 06:58:05 INFO - 'tabpaint']}, 06:58:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:58:05 INFO - 'tests': ['a11yr', 06:58:05 INFO - 'ts_paint', 06:58:05 INFO - 'tpaint', 06:58:05 INFO - 'sessionrestore', 06:58:05 INFO - 'sessionrestore_no_auto_restore', 06:58:05 INFO - 'tabpaint']}, 06:58:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:58:05 INFO - 'tests': ['tsvgx', 06:58:05 INFO - 'tsvgr_opacity', 06:58:05 INFO - 'tart', 06:58:05 INFO - 'tscrollx', 06:58:05 INFO - 'cart']}, 06:58:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:58:05 INFO - 'tsvgr_opacity', 06:58:05 INFO - 'tart', 06:58:05 INFO - 'tscrollx', 06:58:05 INFO - 'cart']}, 06:58:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:05 INFO - 'talos_options': ['--disable-e10s'], 06:58:05 INFO - 'tests': ['tp5o']}, 06:58:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:05 INFO - 'tests': ['tp5o']}, 06:58:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:05 INFO - 'talos_options': ['--disable-e10s', 06:58:05 INFO - '--xperf_path', 06:58:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:58:05 INFO - 'tests': ['tp5n']}, 06:58:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:05 INFO - 'talos_options': ['--xperf_path', 06:58:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:58:05 INFO - 'tests': ['tp5n']}}, 06:58:05 INFO - 'talos.zip': {'path': '', 06:58:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:58:05 INFO - Running post-action listener: _resource_record_post_action 06:58:05 INFO - ##### 06:58:05 INFO - ##### Running create-virtualenv step. 06:58:05 INFO - ##### 06:58:05 INFO - Running pre-action listener: _resource_record_pre_action 06:58:05 INFO - Running main action method: create_virtualenv 06:58:05 INFO - Creating virtualenv /builds/slave/test/build/venv 06:58:05 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 06:58:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:58:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:58:05 INFO - Using real prefix '/tools/python27' 06:58:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:58:05 INFO - Installing distribute.............................................................................................................................................................................................done. 06:58:08 INFO - Installing pip.................done. 06:58:08 INFO - Return code: 0 06:58:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:58:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1087c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d6420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf134b1e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108665e00>, '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 0x1084cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108660b20>, '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.rkKWUJifQ4/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.5hEmXgfcoP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 06:58:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:58:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:58:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rkKWUJifQ4/Render', 06:58:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:58:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:58:08 INFO - 'HOME': '/Users/cltbld', 06:58:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:58:08 INFO - 'LOGNAME': 'cltbld', 06:58:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:08 INFO - 'MOZ_NO_REMOTE': '1', 06:58:08 INFO - 'NO_EM_RESTART': '1', 06:58:08 INFO - 'PAGER': '/bin/cat', 06:58:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:58:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:08 INFO - 'PWD': '/builds/slave/test', 06:58:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:58:08 INFO - 'SHELL': '/bin/bash', 06:58:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5hEmXgfcoP/Listeners', 06:58:08 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 06:58:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:58:08 INFO - 'USER': 'cltbld', 06:58:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:58:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:58:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:08 INFO - 'XPC_FLAGS': '0x0', 06:58:08 INFO - 'XPC_SERVICE_NAME': '0', 06:58:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:09 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 06:58:09 INFO - Cleaning up... 06:58:09 INFO - Return code: 0 06:58:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:58: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')]} 06:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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')]} 06:58:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:09 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 0x1087c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d6420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf134b1e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108665e00>, '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 0x1084cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108660b20>, '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.rkKWUJifQ4/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.5hEmXgfcoP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 06:58:09 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 06:58:09 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 06:58:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rkKWUJifQ4/Render', 06:58:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:58:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:58:09 INFO - 'HOME': '/Users/cltbld', 06:58:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:58:09 INFO - 'LOGNAME': 'cltbld', 06:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:09 INFO - 'MOZ_NO_REMOTE': '1', 06:58:09 INFO - 'NO_EM_RESTART': '1', 06:58:09 INFO - 'PAGER': '/bin/cat', 06:58:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:09 INFO - 'PWD': '/builds/slave/test', 06:58:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:58:09 INFO - 'SHELL': '/bin/bash', 06:58:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5hEmXgfcoP/Listeners', 06:58:09 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 06:58:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:58:09 INFO - 'USER': 'cltbld', 06:58:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:58:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:09 INFO - 'XPC_FLAGS': '0x0', 06:58:09 INFO - 'XPC_SERVICE_NAME': '0', 06:58:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:09 INFO - Downloading/unpacking psutil>=0.7.1 06:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:58:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:58:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:58:12 INFO - Installing collected packages: psutil 06:58:12 INFO - Running setup.py install for psutil 06:58:12 INFO - building 'psutil._psutil_osx' extension 06:58:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:58:13 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 06:58:13 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 06:58:13 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 06:58:13 INFO - building 'psutil._psutil_posix' extension 06:58:13 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 06:58:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:58:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:58:13 INFO - ^ 06:58:13 INFO - 1 warning generated. 06:58:13 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 06:58:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:58:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:58:13 INFO - Successfully installed psutil 06:58:13 INFO - Cleaning up... 06:58:13 INFO - Return code: 0 06:58:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:58: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')]} 06:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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')]} 06:58:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1087c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d6420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf134b1e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108665e00>, '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 0x1084cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108660b20>, '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.rkKWUJifQ4/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.5hEmXgfcoP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 06:58:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:58:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:58:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rkKWUJifQ4/Render', 06:58:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:58:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:58:13 INFO - 'HOME': '/Users/cltbld', 06:58:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:58:13 INFO - 'LOGNAME': 'cltbld', 06:58:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:13 INFO - 'MOZ_NO_REMOTE': '1', 06:58:13 INFO - 'NO_EM_RESTART': '1', 06:58:13 INFO - 'PAGER': '/bin/cat', 06:58:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:58:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:13 INFO - 'PWD': '/builds/slave/test', 06:58:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:58:13 INFO - 'SHELL': '/bin/bash', 06:58:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5hEmXgfcoP/Listeners', 06:58:13 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 06:58:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:58:13 INFO - 'USER': 'cltbld', 06:58:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:58:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:58:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:13 INFO - 'XPC_FLAGS': '0x0', 06:58:13 INFO - 'XPC_SERVICE_NAME': '0', 06:58:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:58:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:58:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:58:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:58:16 INFO - Installing collected packages: mozsystemmonitor 06:58:16 INFO - Running setup.py install for mozsystemmonitor 06:58:16 INFO - Successfully installed mozsystemmonitor 06:58:16 INFO - Cleaning up... 06:58:16 INFO - Return code: 0 06:58:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:58:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1087c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d6420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf134b1e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108665e00>, '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 0x1084cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108660b20>, '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.rkKWUJifQ4/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.5hEmXgfcoP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 06:58:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:58:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:58:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rkKWUJifQ4/Render', 06:58:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:58:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:58:16 INFO - 'HOME': '/Users/cltbld', 06:58:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:58:16 INFO - 'LOGNAME': 'cltbld', 06:58:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:16 INFO - 'MOZ_NO_REMOTE': '1', 06:58:16 INFO - 'NO_EM_RESTART': '1', 06:58:16 INFO - 'PAGER': '/bin/cat', 06:58:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:58:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:16 INFO - 'PWD': '/builds/slave/test', 06:58:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:58:16 INFO - 'SHELL': '/bin/bash', 06:58:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5hEmXgfcoP/Listeners', 06:58:16 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 06:58:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:58:16 INFO - 'USER': 'cltbld', 06:58:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:58:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:58:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:16 INFO - 'XPC_FLAGS': '0x0', 06:58:16 INFO - 'XPC_SERVICE_NAME': '0', 06:58:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:58:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:17 INFO - Downloading/unpacking blobuploader==1.2.4 06:58: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 06:58: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 06:58: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 06:58: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 06:58: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 06:58: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 06:58:19 INFO - Downloading blobuploader-1.2.4.tar.gz 06:58:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:58:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:58:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:20 INFO - Downloading docopt-0.6.1.tar.gz 06:58:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:58:20 INFO - Installing collected packages: blobuploader, requests, docopt 06:58:20 INFO - Running setup.py install for blobuploader 06:58:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:58:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:58:20 INFO - Running setup.py install for requests 06:58:21 INFO - Running setup.py install for docopt 06:58:21 INFO - Successfully installed blobuploader requests docopt 06:58:21 INFO - Cleaning up... 06:58:21 INFO - Return code: 0 06:58:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:58:21 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')]} 06:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:58:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:22 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 0x1087c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d6420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf134b1e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108665e00>, '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 0x1084cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108660b20>, '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.rkKWUJifQ4/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.5hEmXgfcoP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 06:58:22 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 06:58:22 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 06:58:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rkKWUJifQ4/Render', 06:58:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:58:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:58:22 INFO - 'HOME': '/Users/cltbld', 06:58:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:58:22 INFO - 'LOGNAME': 'cltbld', 06:58:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:22 INFO - 'MOZ_NO_REMOTE': '1', 06:58:22 INFO - 'NO_EM_RESTART': '1', 06:58:22 INFO - 'PAGER': '/bin/cat', 06:58:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:58:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:22 INFO - 'PWD': '/builds/slave/test', 06:58:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:58:22 INFO - 'SHELL': '/bin/bash', 06:58:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5hEmXgfcoP/Listeners', 06:58:22 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 06:58:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:58:22 INFO - 'USER': 'cltbld', 06:58:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:58:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:58:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:22 INFO - 'XPC_FLAGS': '0x0', 06:58:22 INFO - 'XPC_SERVICE_NAME': '0', 06:58:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:58:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:58:22 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-7rPXg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:58:22 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-9exe5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:58:22 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-5TB0Iz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:58:22 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-ReUj7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:58:22 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-id8z3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:58:22 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-TYFuGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:58:23 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-33bBoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:58:23 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-FfgjNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:58:23 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-G1cgML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:58:23 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-oR2Uc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:58:23 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-HiP8K8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:58:23 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-Gn7PRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:58:23 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-OVx06C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:58:23 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-6uBhxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:23 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-YFOROi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:58:24 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-tJ403z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:58:24 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-i6v25f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:58:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:58:24 INFO - Running setup.py install for manifestparser 06:58:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:58:24 INFO - Running setup.py install for mozcrash 06:58:24 INFO - Running setup.py install for mozdebug 06:58:24 INFO - Running setup.py install for mozdevice 06:58:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:58:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:58:24 INFO - Running setup.py install for mozfile 06:58:24 INFO - Running setup.py install for mozhttpd 06:58:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:58:25 INFO - Running setup.py install for mozinfo 06:58:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:58:25 INFO - Running setup.py install for mozInstall 06:58:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:58:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:58:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:58:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:58:25 INFO - Running setup.py install for mozleak 06:58:25 INFO - Running setup.py install for mozlog 06:58:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:58:25 INFO - Running setup.py install for moznetwork 06:58:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:58:25 INFO - Running setup.py install for mozprocess 06:58:26 INFO - Running setup.py install for mozprofile 06:58:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:58:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:58:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:58:26 INFO - Running setup.py install for mozrunner 06:58:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:58:26 INFO - Running setup.py install for mozscreenshot 06:58:26 INFO - Running setup.py install for moztest 06:58:26 INFO - Running setup.py install for mozversion 06:58:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:58:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:58:26 INFO - Cleaning up... 06:58:26 INFO - Return code: 0 06:58:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:58:26 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')]} 06:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:26 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')]} 06:58:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:26 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 0x1087c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d6420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf134b1e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108665e00>, '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 0x1084cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108660b20>, '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.rkKWUJifQ4/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.5hEmXgfcoP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 06:58:26 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 06:58:26 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 06:58:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rkKWUJifQ4/Render', 06:58:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:58:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:58:26 INFO - 'HOME': '/Users/cltbld', 06:58:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:58:26 INFO - 'LOGNAME': 'cltbld', 06:58:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:26 INFO - 'MOZ_NO_REMOTE': '1', 06:58:26 INFO - 'NO_EM_RESTART': '1', 06:58:26 INFO - 'PAGER': '/bin/cat', 06:58:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:58:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:26 INFO - 'PWD': '/builds/slave/test', 06:58:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:58:26 INFO - 'SHELL': '/bin/bash', 06:58:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5hEmXgfcoP/Listeners', 06:58:26 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 06:58:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:58:26 INFO - 'USER': 'cltbld', 06:58:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:58:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:58:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:26 INFO - 'XPC_FLAGS': '0x0', 06:58:26 INFO - 'XPC_SERVICE_NAME': '0', 06:58:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:58:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:58:27 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-C0kNHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:58:27 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)) 06:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:58:27 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-uNpP0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:58:27 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)) 06:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:58:27 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-2dGZ96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:58:27 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)) 06:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:58:27 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-noErwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:58:27 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)) 06:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:58:27 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-A57GOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:58:27 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)) 06:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:58:27 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-F7E4m6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:58:27 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)) 06:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:58:27 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-sn26_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:58:27 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)) 06:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:58:27 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-yY0ngJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:58:27 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)) 06:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:58:27 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-QkLUkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:58:28 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)) 06:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:58:28 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-RPVfTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:58:28 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)) 06:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:58:28 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-KDF8zM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:58:28 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)) 06:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:58:28 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-OirDaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:58:28 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)) 06:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:58:28 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-xyvyMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:58:28 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)) 06:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:58:28 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-IqkRCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:58:28 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)) 06:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:28 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-1tuU5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:28 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)) 06:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:58:28 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-ii4UUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:58:28 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)) 06:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:58:28 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-LEVwud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:58:28 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)) 06:58:28 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)) 06:58:28 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)) 06:58:28 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)) 06:58:28 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)) 06:58:28 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)) 06:58:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:58:28 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 06:58:28 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 06:58:28 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 06:58:28 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 06:58:28 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 06:58:28 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 06:58:31 INFO - Downloading blessings-1.6.tar.gz 06:58:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:58:31 INFO - Installing collected packages: blessings 06:58:31 INFO - Running setup.py install for blessings 06:58:31 INFO - Successfully installed blessings 06:58:31 INFO - Cleaning up... 06:58:31 INFO - Return code: 0 06:58:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:58:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:58:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:58:31 INFO - Reading from file tmpfile_stdout 06:58:31 INFO - Current package versions: 06:58:31 INFO - blessings == 1.6 06:58:31 INFO - blobuploader == 1.2.4 06:58:31 INFO - docopt == 0.6.1 06:58:31 INFO - manifestparser == 1.1 06:58:31 INFO - mozInstall == 1.12 06:58:31 INFO - mozcrash == 0.17 06:58:31 INFO - mozdebug == 0.1 06:58:31 INFO - mozdevice == 0.48 06:58:31 INFO - mozfile == 1.2 06:58:31 INFO - mozhttpd == 0.7 06:58:31 INFO - mozinfo == 0.9 06:58:31 INFO - mozleak == 0.1 06:58:31 INFO - mozlog == 3.1 06:58:31 INFO - moznetwork == 0.27 06:58:31 INFO - mozprocess == 0.22 06:58:31 INFO - mozprofile == 0.28 06:58:31 INFO - mozrunner == 6.11 06:58:31 INFO - mozscreenshot == 0.1 06:58:31 INFO - mozsystemmonitor == 0.0 06:58:31 INFO - moztest == 0.7 06:58:31 INFO - mozversion == 1.4 06:58:31 INFO - psutil == 3.1.1 06:58:31 INFO - requests == 1.2.3 06:58:31 INFO - wsgiref == 0.1.2 06:58:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:58:31 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')]} 06:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:31 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')]} 06:58:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:31 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 0x1087c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d6420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf134b1e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108665e00>, '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 0x1084cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108660b20>, '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.rkKWUJifQ4/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.5hEmXgfcoP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 06:58:31 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 06:58:31 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 06:58:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rkKWUJifQ4/Render', 06:58:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:58:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:58:31 INFO - 'HOME': '/Users/cltbld', 06:58:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:58:31 INFO - 'LOGNAME': 'cltbld', 06:58:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:31 INFO - 'MOZ_NO_REMOTE': '1', 06:58:31 INFO - 'NO_EM_RESTART': '1', 06:58:31 INFO - 'PAGER': '/bin/cat', 06:58:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:58:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:31 INFO - 'PWD': '/builds/slave/test', 06:58:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:58:31 INFO - 'SHELL': '/bin/bash', 06:58:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5hEmXgfcoP/Listeners', 06:58:31 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 06:58:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:58:31 INFO - 'USER': 'cltbld', 06:58:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:58:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:58:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:31 INFO - 'XPC_FLAGS': '0x0', 06:58:31 INFO - 'XPC_SERVICE_NAME': '0', 06:58:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:58:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:32 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)) 06:58:32 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)) 06:58:32 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)) 06:58:32 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)) 06:58:32 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)) 06:58:32 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)) 06:58:32 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)) 06:58:32 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)) 06:58:32 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)) 06:58:32 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)) 06:58:32 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)) 06:58:32 INFO - Cleaning up... 06:58:32 INFO - Return code: 0 06:58:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:58:32 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')]} 06:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:32 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')]} 06:58:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:32 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 0x1087c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d6420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf134b1e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108665e00>, '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 0x1084cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108660b20>, '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.rkKWUJifQ4/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.5hEmXgfcoP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 06:58:32 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 06:58:32 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 06:58:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rkKWUJifQ4/Render', 06:58:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:58:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:58:32 INFO - 'HOME': '/Users/cltbld', 06:58:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:58:32 INFO - 'LOGNAME': 'cltbld', 06:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:32 INFO - 'MOZ_NO_REMOTE': '1', 06:58:32 INFO - 'NO_EM_RESTART': '1', 06:58:32 INFO - 'PAGER': '/bin/cat', 06:58:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:32 INFO - 'PWD': '/builds/slave/test', 06:58:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:58:32 INFO - 'SHELL': '/bin/bash', 06:58:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5hEmXgfcoP/Listeners', 06:58:32 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 06:58:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:58:32 INFO - 'USER': 'cltbld', 06:58:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:58:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:32 INFO - 'XPC_FLAGS': '0x0', 06:58:32 INFO - 'XPC_SERVICE_NAME': '0', 06:58:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:58:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:32 INFO - Downloading/unpacking jsonschema 06:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:58:34 INFO - Downloading/unpacking functools32 (from jsonschema) 06:58:34 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 06:58:34 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 06:58:34 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 06:58:34 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 06:58:34 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 06:58:34 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 06:58:35 INFO - Downloading functools32-3.2.3-2.tar.gz 06:58:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:58:35 INFO - warning: no files found matching '*.txt' 06:58:35 INFO - no previously-included directories found matching 'build' 06:58:35 INFO - no previously-included directories found matching 'dist' 06:58:35 INFO - no previously-included directories found matching '.git*' 06:58:35 INFO - Installing collected packages: jsonschema, functools32 06:58:35 INFO - Running setup.py install for functools32 06:58:35 INFO - warning: no files found matching '*.txt' 06:58:35 INFO - no previously-included directories found matching 'build' 06:58:35 INFO - no previously-included directories found matching 'dist' 06:58:35 INFO - no previously-included directories found matching '.git*' 06:58:35 INFO - Successfully installed jsonschema functools32 06:58:35 INFO - Cleaning up... 06:58:35 INFO - Return code: 0 06:58:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:35 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 0x1087c6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d6420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf134b1e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108665e00>, '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 0x1084cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108660b20>, '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.rkKWUJifQ4/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.5hEmXgfcoP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 06:58:35 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 06:58:35 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 06:58:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rkKWUJifQ4/Render', 06:58:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:58:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:58:35 INFO - 'HOME': '/Users/cltbld', 06:58:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:58:35 INFO - 'LOGNAME': 'cltbld', 06:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:35 INFO - 'MOZ_NO_REMOTE': '1', 06:58:35 INFO - 'NO_EM_RESTART': '1', 06:58:35 INFO - 'PAGER': '/bin/cat', 06:58:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:35 INFO - 'PWD': '/builds/slave/test', 06:58:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:58:35 INFO - 'SHELL': '/bin/bash', 06:58:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5hEmXgfcoP/Listeners', 06:58:35 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 06:58:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:58:35 INFO - 'USER': 'cltbld', 06:58:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:58:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:35 INFO - 'XPC_FLAGS': '0x0', 06:58:35 INFO - 'XPC_SERVICE_NAME': '0', 06:58:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:35 INFO - Downloading/unpacking flake8 06:58:35 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 06:58:35 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 06:58:35 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 06:58:35 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 06:58:35 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 06:58:35 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 06:58:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:58:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:58:38 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 06:58:38 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 06:58:38 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 06:58:38 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 06:58:38 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 06:58:38 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 06:58:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:58:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:58:38 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 06:58:38 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 06:58:38 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 06:58:38 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 06:58:38 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 06:58:38 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 06:58:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:58:39 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 06:58:39 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 06:58:39 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 06:58:39 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 06:58:39 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 06:58:39 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 06:58:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:58:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:58:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:58:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:58:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:58:39 INFO - no previously-included directories found matching 'docs/_build' 06:58:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:58:39 INFO - Running setup.py install for pep8 06:58:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:58:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:58:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:58:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:58:39 INFO - no previously-included directories found matching 'docs/_build' 06:58:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:58:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:58:40 INFO - Cleaning up... 06:58:40 INFO - Return code: 0 06:58:40 INFO - Running post-action listener: _resource_record_post_action 06:58:40 INFO - Running post-action listener: _start_resource_monitoring 06:58:40 INFO - Starting resource monitoring. 06:58:40 INFO - ##### 06:58:40 INFO - ##### Running install step. 06:58:40 INFO - ##### 06:58:40 INFO - Running pre-action listener: _resource_record_pre_action 06:58:40 INFO - Running main action method: install 06:58:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:58:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:58:40 INFO - Reading from file tmpfile_stdout 06:58:40 INFO - Detecting whether we're running mozinstall >=1.0... 06:58:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:58:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:58:40 INFO - Reading from file tmpfile_stdout 06:58:40 INFO - Output received: 06:58:40 INFO - Usage: mozinstall [options] installer 06:58:40 INFO - Options: 06:58:40 INFO - -h, --help show this help message and exit 06:58:40 INFO - -d DEST, --destination=DEST 06:58:40 INFO - Directory to install application into. [default: 06:58:40 INFO - "/builds/slave/test"] 06:58:40 INFO - --app=APP Application being installed. [default: firefox] 06:58:40 INFO - mkdir: /builds/slave/test/build/application 06:58:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:58:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 06:59:11 INFO - Reading from file tmpfile_stdout 06:59:11 INFO - Output received: 06:59:11 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 06:59:11 INFO - Running post-action listener: _resource_record_post_action 06:59:11 INFO - ##### 06:59:11 INFO - ##### Running run-tests step. 06:59:11 INFO - ##### 06:59:11 INFO - Running pre-action listener: _resource_record_pre_action 06:59:11 INFO - Running main action method: run_tests 06:59:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:59:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:59:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:59:11 INFO - 2016-05-28 06:59:11.836 screenresolution[1645:7999] starting screenresolution argv=screenresolution get 06:59:11 INFO - 2016-05-28 06:59:11.839 screenresolution[1645:7999] Display 0: 1600x1200x32@60 06:59:11 INFO - 2016-05-28 06:59:11.845 screenresolution[1646:8001] starting screenresolution argv=screenresolution list 06:59:11 INFO - Available Modes on Display 0 06:59:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:59:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:59:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:59:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:59:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:59:12 INFO - Intel Iris: 06:59:12 INFO - Chipset Model: Intel Iris 06:59:12 INFO - Type: GPU 06:59:12 INFO - Bus: Built-In 06:59:12 INFO - VRAM (Dynamic, Max): 1536 MB 06:59:12 INFO - Vendor: Intel (0x8086) 06:59:12 INFO - Device ID: 0x0a2e 06:59:12 INFO - Revision ID: 0x0009 06:59:12 INFO - Displays: 06:59:12 INFO - Display: 06:59:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:59:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:59:12 INFO - Display Serial Number: 1600x1200 60 06:59:12 INFO - Main Display: Yes 06:59:12 INFO - Mirror: Off 06:59:12 INFO - Online: Yes 06:59:12 INFO - Rotation: Supported 06:59:12 INFO - Return code: 0 06:59:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:59:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:59:12 INFO - Python 2.7.3 06:59:12 INFO - Return code: 0 06:59:12 INFO - grabbing minidump binary from tooltool 06:59:12 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')]} 06:59:12 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 0x108665e00>, '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 0x1084cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108660b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:59:12 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 06:59:12 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 06:59:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:59:12 INFO - Return code: 0 06:59:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:59:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:59:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:59:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:59:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:59:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:59:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:59:13 INFO - Return code: 0 06:59:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0071', '--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 06:59:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0071 --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 06:59:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rkKWUJifQ4/Render', 06:59:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:59:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:59:13 INFO - 'HOME': '/Users/cltbld', 06:59:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:59:13 INFO - 'LOGNAME': 'cltbld', 06:59:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:59:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:13 INFO - 'MOZ_NO_REMOTE': '1', 06:59:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:59:13 INFO - 'NO_EM_RESTART': '1', 06:59:13 INFO - 'PAGER': '/bin/cat', 06:59:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:13 INFO - 'PWD': '/builds/slave/test', 06:59:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:59:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:59:13 INFO - 'SHELL': '/bin/bash', 06:59:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5hEmXgfcoP/Listeners', 06:59:13 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 06:59:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:59:13 INFO - 'USER': 'cltbld', 06:59:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:59:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:13 INFO - 'XPC_FLAGS': '0x0', 06:59:13 INFO - 'XPC_SERVICE_NAME': '0', 06:59:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:59:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0071', '--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 06:59:13 INFO - mozversion application_buildid: 20160528051133 06:59:13 INFO - mozversion application_changeset: bfea62662298a8400d559abd40ec7d4d12fbd97d 06:59:13 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:59:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:59:13 INFO - mozversion application_name: Firefox 06:59:13 INFO - mozversion application_remotingname: firefox-dev 06:59:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:59:13 INFO - mozversion application_vendor: Mozilla 06:59:13 INFO - mozversion application_version: 48.0a2 06:59:13 INFO - mozversion platform_buildid: 20160528051133 06:59:13 INFO - mozversion platform_changeset: bfea62662298a8400d559abd40ec7d4d12fbd97d 06:59:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:59:13 INFO - mozversion platform_version: 48.0a2 06:59:13 INFO - using testdate: 1464443953 06:59:13 INFO - actual date: 1464443953 06:59:13 INFO - starting webserver on 'localhost:49279' 06:59:13 INFO - SUITE-START | Running 2 tests 06:59:13 INFO - TEST-START | dromaeo_css 06:59:13 INFO - operating with platform_type : mac_ 06:59:13 INFO - Initialising browser for dromaeo_css test... 06:59:13 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpJBHXIC/profile http://localhost:49279/getInfo.html) 06:59:16 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 06:59:16 INFO - PROCESS | 1664 | colorDepth:24 06:59:16 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 06:59:16 INFO - PROCESS | 1664 | __metrics 06:59:16 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 06:59:16 INFO - TEST-INFO | 1664: exit 0 06:59:16 INFO - Browser initialized. 06:59:16 INFO - Running cycle 1/1 for dromaeo_css test... 06:59:16 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpJBHXIC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:59:28 INFO - PROCESS | 1668 | RSS: Main: 221356032 06:59:28 INFO - PROCESS | 1668 | 07:00:18 INFO - PROCESS | 1668 | 1464444018475 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] 07:02:29 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 07:02:30 INFO - PROCESS | 1668 | RSS: Main: 231624704 07:02:30 INFO - PROCESS | 1668 | 07:05:32 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 07:05:33 INFO - PROCESS | 1668 | RSS: Main: 243060736 07:05:33 INFO - PROCESS | 1668 | 07:08:35 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 07:08:35 INFO - PROCESS | 1668 | RSS: Main: 245088256 07:08:35 INFO - PROCESS | 1668 | 07:11:37 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 07:11:38 INFO - PROCESS | 1668 | RSS: Main: 247480320 07:11:38 INFO - PROCESS | 1668 | 07:14:40 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 07:14:41 INFO - PROCESS | 1668 | RSS: Main: 249610240 07:14:41 INFO - PROCESS | 1668 | 07:17:43 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 07:17:43 INFO - PROCESS | 1668 | RSS: Main: 250617856 07:17:43 INFO - PROCESS | 1668 | 07:17:43 INFO - PROCESS | 1668 | __start_tp_report 07:17:43 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 07:17:43 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 07:17:43 INFO - PROCESS | 1668 | |i|pagename|runs| 07:17:43 INFO - PROCESS | 1668 | |0;dojo.html;2953.6160299161106;3480.912977175572;3491.1446695559575;3552.1474846036945;3571.375009373359;5765.308163020438;5863.8827223455555;5880.059190529516;5919.792807251742;5929;5795.82612521624;5840.240768700074;5840.766369345221;5882.941170588293;5912.083627037805;5212.687238765668;5272.051030814452;5321.310706029789;5330.706811125406;5347.25138480613;5175.8188463403785;5345.786168553253;5369.952859192459;5397.433269506704;5413.64811287267;4413.492448368446;5231.712255825928;5273.947260527403;5318.521333080022;5386.1920711893135;4080.3063479208604;5274.892272622735;5327.733613319338;5338.3593968724;5370.650907690988;5144.56271216947;5223.085959956992;5259.211118332242;5322.92015619766;5323.866903327409;5576.9163462548095;5621.606487545873;5729.856753581152;5750.482456578886;5759.568032397587;6217.658028808413;6220.377962203788;6279.623222606659;6287.591306565058;6289.622622642656;5533.806316778933;6205.627662340274;6205.658688772116;6303.338149494329;6326;5950.464458198783;6008.969955150196;6017.518598512109;6027.7287522061615;6031.969840150771;6280.591761535486;6282.528810339151;6331.27190373113;6341.873162536724;6342.587731797418;6134.803982731532;6204.224471941007;6234.688265586793;6254.3745625438005;6261.7182226799905;6285.528585356116;6289.685515724287;6316.968415157895;6317.241930968313;6331.841703957438;6300.21247344082;6306.3378345274;6325.272593651697;6328.936710632926;6347.174867267318;6175.536834737412;6257;6266.216722909637;6299;6314.9684251579365;4937.679050861682;5006.199008158677;5009.924851127236;5012.498750124958;5025.472325405853;4401.6478681705385;4555.1117532080925;4565.20108980927;4565.383673204141;4570.794314255866;5855.502282306052;5914.940850591525;5955.37468565803;5991.2510936132985;6006.819795406145;6269.7178626961895;6300.905486417708;6302.401271879165;6313.242410910629;6365.522585806083;5848.649081055065;6005.249343832021;6007.639541627516;6010.789622363196;6017.819465416044;5505.201745746925;5518.972405137949;5528.723563821793;5553.944460555343;5566.4990150886615;6493.285738568754;6499.606114695306;6500.609963402211;6505.967470162619;6517.478601711851;6133.028644417115;6209.223847019122;6279.152314437492;6295.559310848196;6300.621962682254;5384.703841288767;6468.741250350122;6469.7412103515335;6538.901916471352;6539.901901471387;6273.498120150286;6291.496680265659;6310.211223597051;6312;6322.810315690536;5442;6149.508039356931;6264.718087685974;6266.749330026748;6274.623522588659;5156.922646160236;6054.788082417271;6168.845778855385;6198.1012753149635;6201.56589038781;6182.6599537025895;6196.1635179252025;6215.223097112861;6226.59527130735;6228.34602366745;4508.661850361171;5211.661242019257;5580.720963951868;6004;6068.393160683896;5117.411497677815;6125.418085281891;6211.192544969125;6226.128342032029;6258.0925765762795;5025.547700706954;5595.608307418442;5875.854208429315;6136.140940268277;6164.044573091178 07:17:43 INFO - PROCESS | 1668 | |1;ext.html;504.39220739009494;532.9120695085309;566.7477972302324;577.7891069759539;580.9419058094188;29801.850990745043;39193.60806391939;39231.607683923154;39411.60588394115;39507.40738888915;40793.55238685681;41110;41324.79337603315;41788;41977.58022419775;9598.5680644371;9787.021297870227;9804.950975245114;9806.607735690564;9817.067378599057;9803.31376803624;9911.851322230172;9939.155171810406;9947.651832185875;9952.805663320412;9868;9943;9949.850752238686;9959.253056020827;9965.900340996606;9860.408375497458;9933.155681767059;9939.602415903355;9950.9502452488;9963.302568820185;9761;9823.754406139904;9847.556859941249;9851.802963940752;9880.456574888378;40313.79843100795;40712.38931416031;40727.98180045493;40866.59133408657;41289.79355103205;2812.7046660100805;3073.9077827665205;3092.58250136231;3117.9064628061196;3254.4304746669477;21805;25594.74405255942;25762.613560796603;26085;27726.861365693043;2718.5786203138546;2720.8775605097817;2752.215618548704;2790.916272511828;2809.606655068292;232864.83567582222;291349.5432522845;292671.53664231754;293038.53480732674;295453;34349.656503435144;35795.463068054;36121.45817812735;36724.63275367265;37177.44233836495;35778.46332305018;36064.09839753975;36194;36207.4568881467;36328.63671363253;15499.922500387425;15713.450029248921;15799.36802527886;15810;16012.599685007968;13163.407646655924;13370.933145334406;13405.463781448632;13427.865721342858;13443.126196797177;8148.877766833502;8450.577471126542;8453.450525715809;8472.915270847336;8523.48859068458;3476.3568739783223;3522.137076416243;3523.2777280657406;3526.594441639193;3541.8583256669444;1026.3328836256494;1037.3775734559356;1173.360518517393;1187.121530067761;1191.7616476704693;30220.4404820671;30397.544036839467;30603;30701.23246918845;31378.9017384395;942.9391934074166;1094.813881640123;1134.9092072634169;1163.4822503985645;1238.578883179723;13598.456061757419;14806.29113616402;15012;15186.924065379824;16199;493849;497184;498794;506869;511731;57242.42757572454;59304.627814886924;61910.69044654748;62436.37563624397;62748;1275.4196840437764;1326.257295914291;1500.4298366620833;1526.206372686197;1531.0507485359149;30757.077287681404;31155.37689246157;31236.219094521908;31783.205419863763;31984.520232197003;54972.72513637566;55462.445375547344;55842;55925.72037139788;56136.719316403156;472880;473024;473397;475179;476518;26880.865595671898;42447.5755242456;43419.56580434155;45147.774261128485;45233.77383113063;43641;43863;44018.559814401444;44019.119617606826;44640.33039504345;37027.25945481129;37192;38051.85844424672;38181.4272785914;38227.617723822405;30790;37948;38029.61970380261;38295.27671254856;38436.42345364878;35407.82296088503;36668.44997324989;37811.432828507044;38892;39431.61989330474;30867.69132308648;31992.720291189024;32383.49480588353;33432.498512521845;34592.44334005026;24686.753132468446;24791;24913;25178.62232066484;25235.87382063078 07:17:43 INFO - PROCESS | 1668 | |2;jquery.html;366.34972923061565;401.0875258786261;404.5933836494321;408.1021752145281;408.65264525153606;15554.922225388886;15925.840741592581;19577.51056223595;19616.313429029968;20342.593148137046;20136.49658758532;20271.898640506777;20527.07628156733;20592.588148237028;21202.57594848106;5464.508194262526;5493.148561972881;5527.170924361338;5636.239107720467;5652.09566469365;6025.307089684698;6083.695815209244;6109;6142.539309551779;6147.4159954804445;5818.854528636797;5984.102384642295;6033.607815492001;6081.452669259766;6094.908576371336;6043.093535969618;6056.242969628796;6145.754169833202;6180.103884936704;6185.938140618581;4933.7286449245275;5495.477929596682;5499.230107784913;5507.614466987313;5510.6969116698565;13114.803277950838;13266.53567125146;13410.731785364336;13420.932895335558;13473.865261347359;2097.916083356664;2164.0802658869916;2178.6405243134864;2185.8032777050144;2333.1600623775425;9354.672586459441;9886.011398860128;10016.499175041292;10138.847917281246;10233.181345492343;1676.136789553381;1721.1566332497111;1730.2646375290576;1750.649870026;1802.0629272778212;75975.62012190014;118305.40847295709;118428;119433;123979.14031289538;9828.361156524803;11909.166358354832;12006.97940675035;12240.510379584895;12393.752124957631;13805.55041720625;14464.20446875432;15401;15440.227988600525;15449.459268925759;7395.816669332881;9055.094490551024;9084.682036128705;9089.454632722058;9111.544422778834;9120.680776172801;9182.403143795633;9187.632494700138;9221.53892305382;9237.353385262966;3788.677962373174;4754.762261886892;4781.6891902026255;4801.063792560417;4807.591354734816;1973.2994786850747;2048.8258498027835;2057.0845973541927;2094.1623350659856;2096.22439697313;888.7866911941088;902.4495058014605;1009.6819501856892;1074.7635520185704;1075.736444571085;17048;20258;20505.692414613495;20807.58384832295;21064.946752662305;953.7949340891741;973.5862258540234;988.2341185581089;1030.2788048366174;1033.9476139862368;7943.4836735612;9197.494137822485;11165.553377864957;11165.888341116484;11219.326840389604;525902.7409725931;607788;631694;639504;650869;66836.6658166706;94342.52828735813;108287.45856270826;125317;129696;965.0783501755947;1008.4755926917961;1073.8765042020111;1075.1345167140528;1076.1060533461164;14487.492937747129;17699.911500442417;17760.644787104444;17876.106194690474;18460.723089153405;50709.49290507195;51196.74401627968;51379.74310128575;52112;53803;68469.65765171142;70340.64829675818;78354;79638.6018069906;80048.59975700085;7889.605519724106;8255.25702686761;8296.502209867427;8315.542645154575;8432.241098301183;12012.819807703067;12658.177218480769;12738.617841464771;12867.292298923649;12930.612081637566;11153.107751380032;11227.775444491228;11321.433928303717;11322.207445479067;11492.138089643144;10865.046370322842;10892.782144357227;11004.779904402027;11024.834627480755;11167.888321116685;8518.829623407373;10352.844707329547;11315.151363647594;11574.47914843851;11585.942070289595;6704.564203326768;8211.38414618894;8299.95850020746;8319.625616847135;8489.660413583388;9783.461909594756;11183.32900026001;11268.492917818881;11269.887301126884;11328.886711132784 07:17:43 INFO - PROCESS | 1668 | |3;mootools.html;1575.6297270141517;1600.11993403628;1829.240865041008;1904.876183048101;1961.5586493039077;7976.441649084566;8638.611262493187;8834.160754728298;9042;9050.230730387917;7104.183018952822;7521.887171692415;8732.388732788708;8737.475751454902;8789.340799440035;2080.771115177329;2281.4524514116615;2427.9317100475823;2465.2973902437807;2467.1241709193246;2342.227065068523;2384.463495713468;2406.290144407404;2444.6577479152934;2453.58289090855;2463.802895768334;2474.059857254241;2478.033566908898;2522.8990840366364;2533.3160046787357;2274.726153354127;2306.3081075677396;2505.2734706934966;2508.3352911478473;2518.0053878717895;2459.323685986368;2470.295965649781;2478.3060742991993;2484.329231107609;2488.4525404411;8965.148310910454;9006.45961242321;9014.59434325457;9021.14299141587;9041.502717350542;5462.453754624546;5611.691356975365;5615.989121958046;5628.662280263197;5635.070213414781;3139.8744050237965;3579.4093974494176;3650.5619325680823;3708.9443658344876;3720.497732806091;1045.9110975567087;1055.9155267578576;1056.9312994655322;1056.978860422795;1060.0406631998055;12263.93868030663;12438.253704777742;12448.688782780413;12481.875181248253;12496.437660305308;4848.17581011229;4894.608431325485;4958.950410495849;4972.129877271463;5012.949870501248;10290.3825770454;10356.275060745675;10374.533146008296;10385.428801415994;10397.376157430579;5577.9442205577425;5578.191162281447;5589.161625756088;5598.272224610774;5602.6918519481005;4446.26636604963;4927.605791536668;5014.2979982802435;5024.447310795809;5030.748462576857;3531.9293614127573;4103.958960410418;4104.363823607286;4211.599898009746;4238.258304796648;1354.9187048777105;1364.522417154008;1370.095736813698;1379.827521559805;1382.3641125082374;901.4906577783531;921.6820197032014;941.1012483078644;945.664289177346;969.2100937735722;5930.555208359304;5995;6022.427869352405;6083.178770865965;6156.003122249934;467.70768269831353;470.407286818611;475.74309872668374;481.30691803803114;483.3185208855567;3789.5073640426567;3900.083480382108;3929.9214015719526;3934.6458818706456;4038.030872590557;10432.426216558162;10587;10647.520861561094;10737.302075365076;11052.336859788278;10550.525226364833;10579.57681692739;10620.09729173029;10654.360738355723;10663.093637040784;8211.302039326723;8492.150784921581;8519.95740021296;8522.70170544028;8594.054653988056;4959.404871415453;5751.45361190703;5945.910811337747;5967.343592204941;6117.082437634391;9472;9597.328187026842;9623.615055397706;9648.75878103053;9694.466804325548;9417.340786144903;9760.804783904425;9923.65267215644;9941;10077.949610252195;6927.930720692729;7482.850342993219;7614.505057171266;7643.082830060428;7729.613519323899;8341.332693384637;8369.288610468178;8378.162183781817;8476.15238476172;8599.828003440021;7377.4098072155175;7493.962530187314;7526.027219248475;7605.277498637621;7657.310842024244;7408.777736667908;7445.664945077377;7480.0649918760155;7545.094588649397;7554.093508778982;7083.2208457068655;7097.645117744195;7124.679389427592;7131.928680713127;7142.285771422816;4791.712497250176;4855.975720121377;4878.853634390974;4919.926201106915;4959.057779021974;4332.740035597874;4680.251159814414;4911.165101932608;4997.725125118153;5130.4100028497205 07:17:43 INFO - PROCESS | 1668 | |4;prototype.html;328.6122375596796;329.3725453012012;335.5671184172418;337.5679130712687;340.90625078103506;6965.756198533052;7003.614801185933;7021.876499760033;7095.822604434892;7101.289871012896;5556.333240011204;6936.271691472399;6951.478639102075;6954.96522517388;6980.127484064492;3890.6498415142632;4875.926861097087;5035.320231768701;5042.294078828967;5053.6715113517685;4969.453360130401;5027.723475208862;5039.72281524516;5066.1387564114;5071.797128114871;4964.907720301528;4973.278874563186;4982.153033984231;4990.4261009983775;4995.150824359867;4963.329950456697;4964.950350496485;4982.676126051795;4983.302337672729;5040.395152581714;3956.6636835868985;4327.3725309830215;4335.826566937319;4338.8047537860875;4359.585839345257;6394.433363825892;6608.207015158164;6649.534532582721;6680.465562755016;6699.799006029827;5969.403059694039;6017.518598512109;6023.427774361428;6028.487578555828;6049.667268300242;5930.614510056833;7417;7419.777406677808;7434.293742094493;7438.7726025205775;4587.472440669332;4882.853514394574;4885.14509960759;4896.853094407174;4910.386201724785;7493.1757506673675;7837.568933708644;7840.13758486566;7876.369890408753;7885.645145968445;4933.45731969483;4949.529794669501;4969.875753106129;4971.527704868032;4978.90042199154;5070.847874563769;5071.721055341992;5075.87310317245;5075.974620126875;5077;5969.701514924236;5982.611130276518;5999.940000600025;6030.944584697748;6041.818745437644;6643.236027856762;6879.931200687929;7463.253674632602;7487.1389790173735;7494.325510704063;1613.4836852207416;1739.3912130754136;1770.4334612924;1776.7068433708553;1778.9466316010542;1052.4737631184407;1056.434807378049;1069.8876617955002;1069.9465026748787;1072.0887245840972;6727.798166055026;6872.244053154149;6890.069840571458;6896.551724138016;6912.755703973233;7541.585212813348;7634.847303053908;7675.347595454337;7694.192109828499;7717;6869.244383117853;6969;6976.860462790716;7024.2273349931465;7025.437964962791;4088.100617864065;4127.09203975125;4152.294110001307;4155.272827255279;4155.646770024521;8183.304419124322;8199.631016604268;8211.794705132419;8221.671133154727;8250.876236856451;7786.922130778733;8055.516668999879;8072.273495385326;8076.152004039609;8087.959560202161;8090;8150.592470376458;8165.877511837327;8188.836223275382;8190.631421586043;6694.263631000488;6871.900495920629;7130.648595160266;7469.663865125974;7821.530708157528;6183.628982261079;6698.799036028927;7158.38936239342;7676.34751046145;7683.039620047494;7202.783916482514;7544.943707880791;8155.429119961545;8162.428629995843;8173.386995975445;3856.9035774105873;4777.570018698334;4784.114938736345;4799.088173247072;4803.183458811941;7628.35159011468;7680.3471704905705;7719.652615632198;7736.497127686683;7785.182555831782;6007.939920600738;7449.47853650261;7458.73894413693;7471.9626401867645;7500.512466689648;5985.610935289366;7226.277372262732;7459.179490255959;7470.8879366810625;7550.885751989452;6242.719077641426;7229.240929702516;7254.637268136466;7314.232005639544;7337;7212.567245965259;7432.479726419315;7432.516886402366;7443.441741869273;7470.589117598584;7009.088818453569;7267.854642907218;7296.854062918605;7302.926970730225;7348.669309881175 07:17:43 INFO - PROCESS | 1668 | |5;yui.html;664.3190729502256;676.2865177238014;710.541700603111;745.1319213116719;769.9576523291219;14546.418143274257;14567.344469498872;14729.042612230198;14818.481353152642;15046.247687615616;13578.728425431485;13578.932105339483;13598.456061757543;13605.93197034016;15326.923365383158;932.5011119051309;938.3290946972913;943.9811203775955;944.0087907696925;948.8624149498319;910.3945875992457;920.4385324951774;922.916937475627;926.106307413346;926.8841394825647;926.9849514781304;946.2997381937352;961.9182369498566;974.4591751577872;980.2550061952896;874.4097734029568;898.3486971945352;971.3686104032365;978.7797745507276;981.470006196653;725.5646612032738;728.0608015659792;728.191707205002;730.1566690472513;733.4096052677593;13632.727345453135;13852.891768658483;15209.011414258039;15257.771133433007;15286.541403757905;12416;12440.81338779919;12661.987041036695;12704.809427858498;12782.680432989157;9885.802283954352;10141.746456338577;10216.13162881156;10228.07947284748;10232.334898231591;3444.225049363873;3485.4423292273113;3496.388132076902;3551.4140166872435;3572.8034958077556;83256.58371708103;84686.72969905456;85415.57292213499;85570;85677.57161214216;8856.38005339633;9167.862482062774;9358.204552612968;9369.90630093704;9437.245020398352;20479.590408191754;20816.583668326548;20834.47913802137;21004.579908401745;21047;7379.298966598165;7414.406847452191;7502.437317201232;7518.360939320219;7632.580208088609;4042.130941847517;4068.2270368629866;4089.3661482470266;4100.220958017967;4135.56576559463;2805.368792021779;3009.8344591047703;3230.5315729219133;3610.783352998776;3648.3250598638806;559.7537083683167;655.6459511863636;661.632793799446;665.4842497064814;669.7488441834312;535.6946540471971;588.1325045557768;592.1916583863082;593.7506247376112;616.9043798211285;8072.071711753224;8160.428769986044;8211.58942052895;8390.496570205807;8441.366897482714;481.32614339924385;555.6915911669063;592.0064257983919;597.2862429396915;612.8682333298362;3750.4186851038135;3909.276783795007;3934.7639141651593;3940.842366305316;4111.650509706648;92753;94773;96006.51996739971;96105;96260;72700;72857;75792.62103689557;76216.61891690506;76387.85418218731;70994.9350759739;71581;71703.6414817933;72382.63808681029;73838.63080684563;6366.9681651591445;7767.300942915164;7861.921380786119;7886.605669716377;8222.876656850272;48049.75975120102;48902.75548622234;49259.26111108408;49676.50323496719;49808.750956244985;65545;69213;69472.95790563247;69794;70434.29565704483;9745.707628771148;9981.500924953869;9987.60049598008;10021.649242276486;10488.05607495329;10746.677599672023;10823.783524329312;10970.945145274223;11020.724481888017;11067.280626759235;10319.400572253327;10447.791044178923;10570.577176912837;10657.573697052341;10750.301230419998;9348.392354496937;9422.481763503074;9533.761655958378;9677.516124193902;9682.56428460735;10131.240156988402;10191.54138063774;10274.383536987805;10330.380177189392;11145.442727863736;8704.042555319036;8906.643734250558;9153.816923661623;9243.76890577714;9247.39891907024;9713.125818676353;9757;9788.559514821707;9805.950970245103;9814.558344874355 07:17:43 INFO - PROCESS | 1668 | __end_tp_report 07:17:43 INFO - PROCESS | 1668 | __start_cc_report 07:17:43 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,424 07:17:43 INFO - PROCESS | 1668 | __end_cc_report 07:17:43 INFO - PROCESS | 1668 | __startTimestamp1464445063676__endTimestamp 07:17:43 INFO - PROCESS | 1668 | 07:17:43 INFO - PROCESS | 1668 | ------- Summary: start ------- 07:17:43 INFO - PROCESS | 1668 | Number of tests: 6 07:17:43 INFO - PROCESS | 1668 | 07:17:43 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5782.43 Median:6010.79 stddev:675.29 (11.2%) stddev-sans-first:639.86 07:17:43 INFO - PROCESS | 1668 | Values: 2953.6 3480.9 3491.1 3552.1 3571.4 5765.3 5863.9 5880.1 5919.8 5929.0 5795.8 5840.2 5840.8 5882.9 5912.1 5212.7 5272.1 5321.3 5330.7 5347.3 5175.8 5345.8 5370.0 5397.4 5413.6 4413.5 5231.7 5273.9 5318.5 5386.2 4080.3 5274.9 5327.7 5338.4 5370.7 5144.6 5223.1 5259.2 5322.9 5323.9 5576.9 5621.6 5729.9 5750.5 5759.6 6217.7 6220.4 6279.6 6287.6 6289.6 5533.8 6205.6 6205.7 6303.3 6326.0 5950.5 6009.0 6017.5 6027.7 6032.0 6280.6 6282.5 6331.3 6341.9 6342.6 6134.8 6204.2 6234.7 6254.4 6261.7 6285.5 6289.7 6317.0 6317.2 6331.8 6300.2 6306.3 6325.3 6328.9 6347.2 6175.5 6257.0 6266.2 6299.0 6315.0 4937.7 5006.2 5009.9 5012.5 5025.5 4401.6 4555.1 4565.2 4565.4 4570.8 5855.5 5914.9 5955.4 5991.3 6006.8 6269.7 6300.9 6302.4 6313.2 6365.5 5848.6 6005.2 6007.6 6010.8 6017.8 5505.2 5519.0 5528.7 5553.9 5566.5 6493.3 6499.6 6500.6 6506.0 6517.5 6133.0 6209.2 6279.2 6295.6 6300.6 5384.7 6468.7 6469.7 6538.9 6539.9 6273.5 6291.5 6310.2 6312.0 6322.8 5442.0 6149.5 6264.7 6266.7 6274.6 5156.9 6054.8 6168.8 6198.1 6201.6 6182.7 6196.2 6215.2 6226.6 6228.3 4508.7 5211.7 5580.7 6004.0 6068.4 5117.4 6125.4 6211.2 6226.1 6258.1 5025.5 5595.6 5875.9 6136.1 6164.0 07:17:43 INFO - PROCESS | 1668 | 07:17:43 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:56176.42 Median:37501.72 stddev:114593.21 (305.6%) stddev-sans-first:114838.44 07:17:43 INFO - PROCESS | 1668 | Values: 504.4 532.9 566.7 577.8 580.9 29801.9 39193.6 39231.6 39411.6 39507.4 40793.6 41110.0 41324.8 41788.0 41977.6 9598.6 9787.0 9805.0 9806.6 9817.1 9803.3 9911.9 9939.2 9947.7 9952.8 9868.0 9943.0 9949.9 9959.3 9965.9 9860.4 9933.2 9939.6 9951.0 9963.3 9761.0 9823.8 9847.6 9851.8 9880.5 40313.8 40712.4 40728.0 40866.6 41289.8 2812.7 3073.9 3092.6 3117.9 3254.4 21805.0 25594.7 25762.6 26085.0 27726.9 2718.6 2720.9 2752.2 2790.9 2809.6 232864.8 291349.5 292671.5 293038.5 295453.0 34349.7 35795.5 36121.5 36724.6 37177.4 35778.5 36064.1 36194.0 36207.5 36328.6 15499.9 15713.5 15799.4 15810.0 16012.6 13163.4 13370.9 13405.5 13427.9 13443.1 8148.9 8450.6 8453.5 8472.9 8523.5 3476.4 3522.1 3523.3 3526.6 3541.9 1026.3 1037.4 1173.4 1187.1 1191.8 30220.4 30397.5 30603.0 30701.2 31378.9 942.9 1094.8 1134.9 1163.5 1238.6 13598.5 14806.3 15012.0 15186.9 16199.0 493849.0 497184.0 498794.0 506869.0 511731.0 57242.4 59304.6 61910.7 62436.4 62748.0 1275.4 1326.3 1500.4 1526.2 1531.1 30757.1 31155.4 31236.2 31783.2 31984.5 54972.7 55462.4 55842.0 55925.7 56136.7 472880.0 473024.0 473397.0 475179.0 476518.0 26880.9 42447.6 43419.6 45147.8 45233.8 43641.0 43863.0 44018.6 44019.1 44640.3 37027.3 37192.0 38051.9 38181.4 38227.6 30790.0 37948.0 38029.6 38295.3 38436.4 35407.8 36668.4 37811.4 38892.0 39431.6 30867.7 31992.7 32383.5 33432.5 34592.4 24686.8 24791.0 24913.0 25178.6 25235.9 07:17:43 INFO - PROCESS | 1668 | 07:17:43 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:34009.17 Median:2171.36 stddev:101638.95 (4680.9%) stddev-sans-first:101892.69 07:17:43 INFO - PROCESS | 1668 | Values: 366.3 401.1 404.6 408.1 408.7 15554.9 15925.8 19577.5 19616.3 20342.6 20136.5 20271.9 20527.1 20592.6 21202.6 5464.5 5493.1 5527.2 5636.2 5652.1 6025.3 6083.7 6109.0 6142.5 6147.4 5818.9 5984.1 6033.6 6081.5 6094.9 6043.1 6056.2 6145.8 6180.1 6185.9 4933.7 5495.5 5499.2 5507.6 5510.7 13114.8 13266.5 13410.7 13420.9 13473.9 2097.9 2164.1 2178.6 2185.8 2333.2 9354.7 9886.0 10016.5 10138.8 10233.2 1676.1 1721.2 1730.3 1750.6 1802.1 75975.6 118305.4 118428.0 119433.0 123979.1 9828.4 11909.2 12007.0 12240.5 12393.8 13805.6 14464.2 15401.0 15440.2 15449.5 7395.8 9055.1 9084.7 9089.5 9111.5 9120.7 9182.4 9187.6 9221.5 9237.4 3788.7 4754.8 4781.7 4801.1 4807.6 1973.3 2048.8 2057.1 2094.2 2096.2 888.8 902.4 1009.7 1074.8 1075.7 17048.0 20258.0 20505.7 20807.6 21064.9 953.8 973.6 988.2 1030.3 1033.9 7943.5 9197.5 11165.6 11165.9 11219.3 525902.7 607788.0 631694.0 639504.0 650869.0 66836.7 94342.5 108287.5 125317.0 129696.0 965.1 1008.5 1073.9 1075.1 1076.1 14487.5 17699.9 17760.6 17876.1 18460.7 50709.5 51196.7 51379.7 52112.0 53803.0 68469.7 70340.6 78354.0 79638.6 80048.6 7889.6 8255.3 8296.5 8315.5 8432.2 12012.8 12658.2 12738.6 12867.3 12930.6 11153.1 11227.8 11321.4 11322.2 11492.1 10865.0 10892.8 11004.8 11024.8 11167.9 8518.8 10352.8 11315.2 11574.5 11585.9 6704.6 8211.4 8300.0 8319.6 8489.7 9783.5 11183.3 11268.5 11269.9 11328.9 07:17:43 INFO - PROCESS | 1668 | 07:17:43 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:5769.11 Median:4923.77 stddev:3236.97 (65.7%) stddev-sans-first:3230.71 07:17:43 INFO - PROCESS | 1668 | Values: 1575.6 1600.1 1829.2 1904.9 1961.6 7976.4 8638.6 8834.2 9042.0 9050.2 7104.2 7521.9 8732.4 8737.5 8789.3 2080.8 2281.5 2427.9 2465.3 2467.1 2342.2 2384.5 2406.3 2444.7 2453.6 2463.8 2474.1 2478.0 2522.9 2533.3 2274.7 2306.3 2505.3 2508.3 2518.0 2459.3 2470.3 2478.3 2484.3 2488.5 8965.1 9006.5 9014.6 9021.1 9041.5 5462.5 5611.7 5616.0 5628.7 5635.1 3139.9 3579.4 3650.6 3708.9 3720.5 1045.9 1055.9 1056.9 1057.0 1060.0 12263.9 12438.3 12448.7 12481.9 12496.4 4848.2 4894.6 4959.0 4972.1 5012.9 10290.4 10356.3 10374.5 10385.4 10397.4 5577.9 5578.2 5589.2 5598.3 5602.7 4446.3 4927.6 5014.3 5024.4 5030.7 3531.9 4104.0 4104.4 4211.6 4238.3 1354.9 1364.5 1370.1 1379.8 1382.4 901.5 921.7 941.1 945.7 969.2 5930.6 5995.0 6022.4 6083.2 6156.0 467.7 470.4 475.7 481.3 483.3 3789.5 3900.1 3929.9 3934.6 4038.0 10432.4 10587.0 10647.5 10737.3 11052.3 10550.5 10579.6 10620.1 10654.4 10663.1 8211.3 8492.2 8520.0 8522.7 8594.1 4959.4 5751.5 5945.9 5967.3 6117.1 9472.0 9597.3 9623.6 9648.8 9694.5 9417.3 9760.8 9923.7 9941.0 10077.9 6927.9 7482.9 7614.5 7643.1 7729.6 8341.3 8369.3 8378.2 8476.2 8599.8 7377.4 7494.0 7526.0 7605.3 7657.3 7408.8 7445.7 7480.1 7545.1 7554.1 7083.2 7097.6 7124.7 7131.9 7142.3 4791.7 4856.0 4878.9 4919.9 4959.1 4332.7 4680.3 4911.2 4997.7 5130.4 07:17:43 INFO - PROCESS | 1668 | 07:17:43 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:6027.26 Median:6870.57 stddev:1947.32 (28.3%) stddev-sans-first:1905.23 07:17:43 INFO - PROCESS | 1668 | Values: 328.6 329.4 335.6 337.6 340.9 6965.8 7003.6 7021.9 7095.8 7101.3 5556.3 6936.3 6951.5 6955.0 6980.1 3890.6 4875.9 5035.3 5042.3 5053.7 4969.5 5027.7 5039.7 5066.1 5071.8 4964.9 4973.3 4982.2 4990.4 4995.2 4963.3 4965.0 4982.7 4983.3 5040.4 3956.7 4327.4 4335.8 4338.8 4359.6 6394.4 6608.2 6649.5 6680.5 6699.8 5969.4 6017.5 6023.4 6028.5 6049.7 5930.6 7417.0 7419.8 7434.3 7438.8 4587.5 4882.9 4885.1 4896.9 4910.4 7493.2 7837.6 7840.1 7876.4 7885.6 4933.5 4949.5 4969.9 4971.5 4978.9 5070.8 5071.7 5075.9 5076.0 5077.0 5969.7 5982.6 5999.9 6030.9 6041.8 6643.2 6879.9 7463.3 7487.1 7494.3 1613.5 1739.4 1770.4 1776.7 1778.9 1052.5 1056.4 1069.9 1069.9 1072.1 6727.8 6872.2 6890.1 6896.6 6912.8 7541.6 7634.8 7675.3 7694.2 7717.0 6869.2 6969.0 6976.9 7024.2 7025.4 4088.1 4127.1 4152.3 4155.3 4155.6 8183.3 8199.6 8211.8 8221.7 8250.9 7786.9 8055.5 8072.3 8076.2 8088.0 8090.0 8150.6 8165.9 8188.8 8190.6 6694.3 6871.9 7130.6 7469.7 7821.5 6183.6 6698.8 7158.4 7676.3 7683.0 7202.8 7544.9 8155.4 8162.4 8173.4 3856.9 4777.6 4784.1 4799.1 4803.2 7628.4 7680.3 7719.7 7736.5 7785.2 6007.9 7449.5 7458.7 7472.0 7500.5 5985.6 7226.3 7459.2 7470.9 7550.9 6242.7 7229.2 7254.6 7314.2 7337.0 7212.6 7432.5 7432.5 7443.4 7470.6 7009.1 7267.9 7296.9 7302.9 7348.7 07:17:43 INFO - PROCESS | 1668 | 07:17:43 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:18239.28 Median:69342.98 stddev:26223.09 (37.8%) stddev-sans-first:26263.45 07:17:43 INFO - PROCESS | 1668 | Values: 664.3 676.3 710.5 745.1 770.0 14546.4 14567.3 14729.0 14818.5 15046.2 13578.7 13578.9 13598.5 13605.9 15326.9 932.5 938.3 944.0 944.0 948.9 910.4 920.4 922.9 926.1 926.9 927.0 946.3 961.9 974.5 980.3 874.4 898.3 971.4 978.8 981.5 725.6 728.1 728.2 730.2 733.4 13632.7 13852.9 15209.0 15257.8 15286.5 12416.0 12440.8 12662.0 12704.8 12782.7 9885.8 10141.7 10216.1 10228.1 10232.3 3444.2 3485.4 3496.4 3551.4 3572.8 83256.6 84686.7 85415.6 85570.0 85677.6 8856.4 9167.9 9358.2 9369.9 9437.2 20479.6 20816.6 20834.5 21004.6 21047.0 7379.3 7414.4 7502.4 7518.4 7632.6 4042.1 4068.2 4089.4 4100.2 4135.6 2805.4 3009.8 3230.5 3610.8 3648.3 559.8 655.6 661.6 665.5 669.7 535.7 588.1 592.2 593.8 616.9 8072.1 8160.4 8211.6 8390.5 8441.4 481.3 555.7 592.0 597.3 612.9 3750.4 3909.3 3934.8 3940.8 4111.7 92753.0 94773.0 96006.5 96105.0 96260.0 72700.0 72857.0 75792.6 76216.6 76387.9 70994.9 71581.0 71703.6 72382.6 73838.6 6367.0 7767.3 7861.9 7886.6 8222.9 48049.8 48902.8 49259.3 49676.5 49808.8 65545.0 69213.0 69473.0 69794.0 70434.3 9745.7 9981.5 9987.6 10021.6 10488.1 10746.7 10823.8 10970.9 11020.7 11067.3 10319.4 10447.8 10570.6 10657.6 10750.3 9348.4 9422.5 9533.8 9677.5 9682.6 10131.2 10191.5 10274.4 10330.4 11145.4 8704.0 8906.6 9153.8 9243.8 9247.4 9713.1 9757.0 9788.6 9806.0 9814.6 07:17:43 INFO - PROCESS | 1668 | -------- Summary: end -------- 07:17:43 INFO - PROCESS | 1668 | 07:17:44 INFO - TEST-INFO | 1668: exit 0 07:17:44 INFO - TEST-OK | dromaeo_css | took 1110704ms 07:17:44 INFO - TEST-START | kraken 07:17:44 INFO - operating with platform_type : mac_ 07:17:44 INFO - Initialising browser for kraken test... 07:17:44 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpopgbiG/profile http://localhost:49279/getInfo.html) 07:17:46 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 07:17:46 INFO - PROCESS | 1675 | colorDepth:24 07:17:46 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 07:17:46 INFO - PROCESS | 1675 | __metrics 07:17:47 ERROR - PROCESS | 1675 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 07:17:47 INFO - TEST-INFO | 1675: exit 0 07:17:47 INFO - Browser initialized. 07:17:47 INFO - Running cycle 1/1 for kraken test... 07:17:47 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpopgbiG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:17:59 INFO - PROCESS | 1678 | RSS: Main: 220852224 07:17:59 INFO - PROCESS | 1678 | 07:18:02 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 07:18:03 INFO - PROCESS | 1678 | RSS: Main: 232718336 07:18:03 INFO - PROCESS | 1678 | 07:18:05 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 07:18:06 INFO - PROCESS | 1678 | RSS: Main: 241672192 07:18:06 INFO - PROCESS | 1678 | 07:18:09 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 07:18:10 INFO - PROCESS | 1678 | RSS: Main: 245719040 07:18:10 INFO - PROCESS | 1678 | 07:18:12 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 07:18:12 INFO - PROCESS | 1678 | RSS: Main: 247025664 07:18:12 INFO - PROCESS | 1678 | 07:18:14 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:18:15 INFO - PROCESS | 1678 | RSS: Main: 247500800 07:18:15 INFO - PROCESS | 1678 | 07:18:18 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 07:18:19 INFO - PROCESS | 1678 | RSS: Main: 248094720 07:18:19 INFO - PROCESS | 1678 | 07:18:22 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 07:18:22 INFO - PROCESS | 1678 | RSS: Main: 247746560 07:18:22 INFO - PROCESS | 1678 | 07:18:25 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 07:18:26 INFO - PROCESS | 1678 | RSS: Main: 247840768 07:18:26 INFO - PROCESS | 1678 | 07:18:28 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:18:28 INFO - PROCESS | 1678 | RSS: Main: 247934976 07:18:28 INFO - PROCESS | 1678 | 07:18:30 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:18:31 INFO - PROCESS | 1678 | RSS: Main: 247083008 07:18:31 INFO - PROCESS | 1678 | 07:18:33 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:18:34 INFO - PROCESS | 1678 | RSS: Main: 247222272 07:18:34 INFO - PROCESS | 1678 | 07:18:37 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:18:37 INFO - PROCESS | 1678 | RSS: Main: 247177216 07:18:37 INFO - PROCESS | 1678 | 07:18:40 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:18:41 INFO - PROCESS | 1678 | RSS: Main: 247099392 07:18:41 INFO - PROCESS | 1678 | 07:18:43 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 07:18:43 INFO - PROCESS | 1678 | RSS: Main: 249257984 07:18:43 INFO - PROCESS | 1678 | 07:18:43 INFO - PROCESS | 1678 | __start_tp_report 07:18:43 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 07:18:43 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 07:18:43 INFO - PROCESS | 1678 | |i|pagename|runs| 07:18:43 INFO - PROCESS | 1678 | |0;ai-astar;112;119;108;114;118;117;107;118;115;114 07:18:43 INFO - PROCESS | 1678 | |1;audio-beat-detection;158;147;132;194;152;167;140;123;172;127 07:18:43 INFO - PROCESS | 1678 | |2;audio-dft;192;194;196;204;199;197;196;192;202;193 07:18:43 INFO - PROCESS | 1678 | |3;audio-fft;67;81;74;142;57;56;57;63;127;56 07:18:43 INFO - PROCESS | 1678 | |4;audio-oscillator;79;83;131;79;82;89;123;84;80;121 07:18:43 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;89;86;87;105;112;84;87;85;107;131 07:18:43 INFO - PROCESS | 1678 | |6;imaging-darkroom;97;94;93;90;149;117;97;151;152;95 07:18:43 INFO - PROCESS | 1678 | |7;imaging-desaturate;150;149;97;92;90;89;91;87;131;119 07:18:43 INFO - PROCESS | 1678 | |8;json-parse-financial;63;65;66;65;66;69;66;68;73;76 07:18:43 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;68;66;72;72;72;77;62;79;101;58 07:18:43 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;87;73;105;107;69;78;75;92;103;109 07:18:43 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;132;138;151;129;128;131;131;144;198;176 07:18:43 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;195;232;159;218;207;168;170;181;188;227 07:18:43 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;71;97;101;99;68;68;75;99;89;68 07:18:43 INFO - PROCESS | 1678 | __end_tp_report 07:18:43 INFO - PROCESS | 1678 | __start_cc_report 07:18:43 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1088 07:18:43 INFO - PROCESS | 1678 | __end_cc_report 07:18:43 INFO - PROCESS | 1678 | __startTimestamp1464445123552__endTimestamp 07:18:43 INFO - PROCESS | 1678 | 07:18:43 INFO - PROCESS | 1678 | ------- Summary: start ------- 07:18:43 INFO - PROCESS | 1678 | Number of tests: 14 07:18:43 INFO - PROCESS | 1678 | 07:18:43 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:114.20 Median:116.00 stddev:4.16 (3.6%) stddev-sans-first:4.33 07:18:43 INFO - PROCESS | 1678 | Values: 112.0 119.0 108.0 114.0 118.0 117.0 107.0 118.0 115.0 114.0 07:18:43 INFO - PROCESS | 1678 | 07:18:43 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:155.00 stddev:22.25 (14.4%) stddev-sans-first:23.46 07:18:43 INFO - PROCESS | 1678 | Values: 158.0 147.0 132.0 194.0 152.0 167.0 140.0 123.0 172.0 127.0 07:18:43 INFO - PROCESS | 1678 | 07:18:43 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:196.50 Median:196.50 stddev:4.12 (2.1%) stddev-sans-first:4.03 07:18:43 INFO - PROCESS | 1678 | Values: 192.0 194.0 196.0 204.0 199.0 197.0 196.0 192.0 202.0 193.0 07:18:43 INFO - PROCESS | 1678 | 07:18:43 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:78.00 Median:60.00 stddev:31.12 (51.9%) stddev-sans-first:32.76 07:18:43 INFO - PROCESS | 1678 | Values: 67.0 81.0 74.0 142.0 57.0 56.0 57.0 63.0 127.0 56.0 07:18:43 INFO - PROCESS | 1678 | 07:18:43 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:81.00 stddev:20.98 (25.9%) stddev-sans-first:21.43 07:18:43 INFO - PROCESS | 1678 | Values: 79.0 83.0 131.0 79.0 82.0 89.0 123.0 84.0 80.0 121.0 07:18:43 INFO - PROCESS | 1678 | 07:18:43 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:97.30 Median:85.50 stddev:15.78 (18.5%) stddev-sans-first:16.45 07:18:43 INFO - PROCESS | 1678 | Values: 89.0 86.0 87.0 105.0 112.0 84.0 87.0 85.0 107.0 131.0 07:18:43 INFO - PROCESS | 1678 | 07:18:43 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:113.50 Median:93.50 stddev:26.67 (28.5%) stddev-sans-first:27.61 07:18:43 INFO - PROCESS | 1678 | Values: 97.0 94.0 93.0 90.0 149.0 117.0 97.0 151.0 152.0 95.0 07:18:43 INFO - PROCESS | 1678 | 07:18:43 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:109.50 Median:89.50 stddev:25.53 (28.5%) stddev-sans-first:22.48 07:18:43 INFO - PROCESS | 1678 | Values: 150.0 149.0 97.0 92.0 90.0 89.0 91.0 87.0 131.0 119.0 07:18:43 INFO - PROCESS | 1678 | 07:18:43 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:67.70 Median:67.00 stddev:4.00 (6.0%) stddev-sans-first:3.87 07:18:43 INFO - PROCESS | 1678 | Values: 63.0 65.0 66.0 65.0 66.0 69.0 66.0 68.0 73.0 76.0 07:18:43 INFO - PROCESS | 1678 | 07:18:43 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:72.70 Median:72.00 stddev:11.82 (16.4%) stddev-sans-first:12.42 07:18:43 INFO - PROCESS | 1678 | Values: 68.0 66.0 72.0 72.0 72.0 77.0 62.0 79.0 101.0 58.0 07:18:43 INFO - PROCESS | 1678 | 07:18:43 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:89.80 Median:74.00 stddev:15.48 (20.9%) stddev-sans-first:16.38 07:18:43 INFO - PROCESS | 1678 | Values: 87.0 73.0 105.0 107.0 69.0 78.0 75.0 92.0 103.0 109.0 07:18:43 INFO - PROCESS | 1678 | 07:18:43 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:145.80 Median:141.00 stddev:23.47 (16.6%) stddev-sans-first:24.35 07:18:43 INFO - PROCESS | 1678 | Values: 132.0 138.0 151.0 129.0 128.0 131.0 131.0 144.0 198.0 176.0 07:18:43 INFO - PROCESS | 1678 | 07:18:43 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.50 Median:201.00 stddev:25.73 (12.8%) stddev-sans-first:27.29 07:18:43 INFO - PROCESS | 1678 | Values: 195.0 232.0 159.0 218.0 207.0 168.0 170.0 181.0 188.0 227.0 07:18:43 INFO - PROCESS | 1678 | 07:18:43 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:83.50 Median:82.00 stddev:14.71 (17.9%) stddev-sans-first:14.90 07:18:43 INFO - PROCESS | 1678 | Values: 71.0 97.0 101.0 99.0 68.0 68.0 75.0 99.0 89.0 68.0 07:18:43 INFO - PROCESS | 1678 | -------- Summary: end -------- 07:18:43 INFO - PROCESS | 1678 | 07:18:44 INFO - TEST-INFO | 1678: exit 0 07:18:44 INFO - TEST-OK | kraken | took 60209ms 07:18:44 INFO - SUITE-END | took 1170s 07:18:44 INFO - Completed test suite (00:19:31) 07:18:44 INFO - javascript benchmark 07:18:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2953.6160299161106, 3480.912977175572, 3491.1446695559575, 3552.1474846036945, 3571.375009373359, 5765.308163020438, 5863.8827223455555, 5880.059190529516, 5919.792807251742, 5929.0, 5795.82612521624, 5840.240768700074, 5840.766369345221, 5882.941170588293, 5912.083627037805, 5212.687238765668, 5272.051030814452, 5321.310706029789, 5330.706811125406, 5347.25138480613, 5175.8188463403785, 5345.786168553253, 5369.952859192459, 5397.433269506704, 5413.64811287267, 4413.492448368446, 5231.712255825928, 5273.947260527403, 5318.521333080022, 5386.1920711893135, 4080.3063479208604, 5274.892272622735, 5327.733613319338, 5338.3593968724, 5370.650907690988, 5144.56271216947, 5223.085959956992, 5259.211118332242, 5322.92015619766, 5323.866903327409, 5576.9163462548095, 5621.606487545873, 5729.856753581152, 5750.482456578886, 5759.568032397587, 6217.658028808413, 6220.377962203788, 6279.623222606659, 6287.591306565058, 6289.622622642656, 5533.806316778933, 6205.627662340274, 6205.658688772116, 6303.338149494329, 6326.0, 5950.464458198783, 6008.969955150196, 6017.518598512109, 6027.7287522061615, 6031.969840150771, 6280.591761535486, 6282.528810339151, 6331.27190373113, 6341.873162536724, 6342.587731797418, 6134.803982731532, 6204.224471941007, 6234.688265586793, 6254.3745625438005, 6261.7182226799905, 6285.528585356116, 6289.685515724287, 6316.968415157895, 6317.241930968313, 6331.841703957438, 6300.21247344082, 6306.3378345274, 6325.272593651697, 6328.936710632926, 6347.174867267318, 6175.536834737412, 6257.0, 6266.216722909637, 6299.0, 6314.9684251579365, 4937.679050861682, 5006.199008158677, 5009.924851127236, 5012.498750124958, 5025.472325405853, 4401.6478681705385, 4555.1117532080925, 4565.20108980927, 4565.383673204141, 4570.794314255866, 5855.502282306052, 5914.940850591525, 5955.37468565803, 5991.2510936132985, 6006.819795406145, 6269.7178626961895, 6300.905486417708, 6302.401271879165, 6313.242410910629, 6365.522585806083, 5848.649081055065, 6005.249343832021, 6007.639541627516, 6010.789622363196, 6017.819465416044, 5505.201745746925, 5518.972405137949, 5528.723563821793, 5553.944460555343, 5566.4990150886615, 6493.285738568754, 6499.606114695306, 6500.609963402211, 6505.967470162619, 6517.478601711851, 6133.028644417115, 6209.223847019122, 6279.152314437492, 6295.559310848196, 6300.621962682254, 5384.703841288767, 6468.741250350122, 6469.7412103515335, 6538.901916471352, 6539.901901471387, 6273.498120150286, 6291.496680265659, 6310.211223597051, 6312.0, 6322.810315690536, 5442.0, 6149.508039356931, 6264.718087685974, 6266.749330026748, 6274.623522588659, 5156.922646160236, 6054.788082417271, 6168.845778855385, 6198.1012753149635, 6201.56589038781, 6182.6599537025895, 6196.1635179252025, 6215.223097112861, 6226.59527130735, 6228.34602366745, 4508.661850361171, 5211.661242019257, 5580.720963951868, 6004.0, 6068.393160683896, 5117.411497677815, 6125.418085281891, 6211.192544969125, 6226.128342032029, 6258.0925765762795, 5025.547700706954, 5595.608307418442, 5875.854208429315, 6136.140940268277, 6164.044573091178], "value": 5741.351664796671, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [504.39220739009494, 532.9120695085309, 566.7477972302324, 577.7891069759539, 580.9419058094188, 29801.850990745043, 39193.60806391939, 39231.607683923154, 39411.60588394115, 39507.40738888915, 40793.55238685681, 41110.0, 41324.79337603315, 41788.0, 41977.58022419775, 9598.5680644371, 9787.021297870227, 9804.950975245114, 9806.607735690564, 9817.067378599057, 9803.31376803624, 9911.851322230172, 9939.155171810406, 9947.651832185875, 9952.805663320412, 9868.0, 9943.0, 9949.850752238686, 9959.253056020827, 9965.900340996606, 9860.408375497458, 9933.155681767059, 9939.602415903355, 9950.9502452488, 9963.302568820185, 9761.0, 9823.754406139904, 9847.556859941249, 9851.802963940752, 9880.456574888378, 40313.79843100795, 40712.38931416031, 40727.98180045493, 40866.59133408657, 41289.79355103205, 2812.7046660100805, 3073.9077827665205, 3092.58250136231, 3117.9064628061196, 3254.4304746669477, 21805.0, 25594.74405255942, 25762.613560796603, 26085.0, 27726.861365693043, 2718.5786203138546, 2720.8775605097817, 2752.215618548704, 2790.916272511828, 2809.606655068292, 232864.83567582222, 291349.5432522845, 292671.53664231754, 293038.53480732674, 295453.0, 34349.656503435144, 35795.463068054, 36121.45817812735, 36724.63275367265, 37177.44233836495, 35778.46332305018, 36064.09839753975, 36194.0, 36207.4568881467, 36328.63671363253, 15499.922500387425, 15713.450029248921, 15799.36802527886, 15810.0, 16012.599685007968, 13163.407646655924, 13370.933145334406, 13405.463781448632, 13427.865721342858, 13443.126196797177, 8148.877766833502, 8450.577471126542, 8453.450525715809, 8472.915270847336, 8523.48859068458, 3476.3568739783223, 3522.137076416243, 3523.2777280657406, 3526.594441639193, 3541.8583256669444, 1026.3328836256494, 1037.3775734559356, 1173.360518517393, 1187.121530067761, 1191.7616476704693, 30220.4404820671, 30397.544036839467, 30603.0, 30701.23246918845, 31378.9017384395, 942.9391934074166, 1094.813881640123, 1134.9092072634169, 1163.4822503985645, 1238.578883179723, 13598.456061757419, 14806.29113616402, 15012.0, 15186.924065379824, 16199.0, 493849.0, 497184.0, 498794.0, 506869.0, 511731.0, 57242.42757572454, 59304.627814886924, 61910.69044654748, 62436.37563624397, 62748.0, 1275.4196840437764, 1326.257295914291, 1500.4298366620833, 1526.206372686197, 1531.0507485359149, 30757.077287681404, 31155.37689246157, 31236.219094521908, 31783.205419863763, 31984.520232197003, 54972.72513637566, 55462.445375547344, 55842.0, 55925.72037139788, 56136.719316403156, 472880.0, 473024.0, 473397.0, 475179.0, 476518.0, 26880.865595671898, 42447.5755242456, 43419.56580434155, 45147.774261128485, 45233.77383113063, 43641.0, 43863.0, 44018.559814401444, 44019.119617606826, 44640.33039504345, 37027.25945481129, 37192.0, 38051.85844424672, 38181.4272785914, 38227.617723822405, 30790.0, 37948.0, 38029.61970380261, 38295.27671254856, 38436.42345364878, 35407.82296088503, 36668.44997324989, 37811.432828507044, 38892.0, 39431.61989330474, 30867.69132308648, 31992.720291189024, 32383.49480588353, 33432.498512521845, 34592.44334005026, 24686.753132468446, 24791.0, 24913.0, 25178.62232066484, 25235.87382063078], "value": 18250.928227575616, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.34972923061565, 401.0875258786261, 404.5933836494321, 408.1021752145281, 408.65264525153606, 15554.922225388886, 15925.840741592581, 19577.51056223595, 19616.313429029968, 20342.593148137046, 20136.49658758532, 20271.898640506777, 20527.07628156733, 20592.588148237028, 21202.57594848106, 5464.508194262526, 5493.148561972881, 5527.170924361338, 5636.239107720467, 5652.09566469365, 6025.307089684698, 6083.695815209244, 6109.0, 6142.539309551779, 6147.4159954804445, 5818.854528636797, 5984.102384642295, 6033.607815492001, 6081.452669259766, 6094.908576371336, 6043.093535969618, 6056.242969628796, 6145.754169833202, 6180.103884936704, 6185.938140618581, 4933.7286449245275, 5495.477929596682, 5499.230107784913, 5507.614466987313, 5510.6969116698565, 13114.803277950838, 13266.53567125146, 13410.731785364336, 13420.932895335558, 13473.865261347359, 2097.916083356664, 2164.0802658869916, 2178.6405243134864, 2185.8032777050144, 2333.1600623775425, 9354.672586459441, 9886.011398860128, 10016.499175041292, 10138.847917281246, 10233.181345492343, 1676.136789553381, 1721.1566332497111, 1730.2646375290576, 1750.649870026, 1802.0629272778212, 75975.62012190014, 118305.40847295709, 118428.0, 119433.0, 123979.14031289538, 9828.361156524803, 11909.166358354832, 12006.97940675035, 12240.510379584895, 12393.752124957631, 13805.55041720625, 14464.20446875432, 15401.0, 15440.227988600525, 15449.459268925759, 7395.816669332881, 9055.094490551024, 9084.682036128705, 9089.454632722058, 9111.544422778834, 9120.680776172801, 9182.403143795633, 9187.632494700138, 9221.53892305382, 9237.353385262966, 3788.677962373174, 4754.762261886892, 4781.6891902026255, 4801.063792560417, 4807.591354734816, 1973.2994786850747, 2048.8258498027835, 2057.0845973541927, 2094.1623350659856, 2096.22439697313, 888.7866911941088, 902.4495058014605, 1009.6819501856892, 1074.7635520185704, 1075.736444571085, 17048.0, 20258.0, 20505.692414613495, 20807.58384832295, 21064.946752662305, 953.7949340891741, 973.5862258540234, 988.2341185581089, 1030.2788048366174, 1033.9476139862368, 7943.4836735612, 9197.494137822485, 11165.553377864957, 11165.888341116484, 11219.326840389604, 525902.7409725931, 607788.0, 631694.0, 639504.0, 650869.0, 66836.6658166706, 94342.52828735813, 108287.45856270826, 125317.0, 129696.0, 965.0783501755947, 1008.4755926917961, 1073.8765042020111, 1075.1345167140528, 1076.1060533461164, 14487.492937747129, 17699.911500442417, 17760.644787104444, 17876.106194690474, 18460.723089153405, 50709.49290507195, 51196.74401627968, 51379.74310128575, 52112.0, 53803.0, 68469.65765171142, 70340.64829675818, 78354.0, 79638.6018069906, 80048.59975700085, 7889.605519724106, 8255.25702686761, 8296.502209867427, 8315.542645154575, 8432.241098301183, 12012.819807703067, 12658.177218480769, 12738.617841464771, 12867.292298923649, 12930.612081637566, 11153.107751380032, 11227.775444491228, 11321.433928303717, 11322.207445479067, 11492.138089643144, 10865.046370322842, 10892.782144357227, 11004.779904402027, 11024.834627480755, 11167.888321116685, 8518.829623407373, 10352.844707329547, 11315.151363647594, 11574.47914843851, 11585.942070289595, 6704.564203326768, 8211.38414618894, 8299.95850020746, 8319.625616847135, 8489.660413583388, 9783.461909594756, 11183.32900026001, 11268.492917818881, 11269.887301126884, 11328.886711132784], "value": 9324.292414266227, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1575.6297270141517, 1600.11993403628, 1829.240865041008, 1904.876183048101, 1961.5586493039077, 7976.441649084566, 8638.611262493187, 8834.160754728298, 9042.0, 9050.230730387917, 7104.183018952822, 7521.887171692415, 8732.388732788708, 8737.475751454902, 8789.340799440035, 2080.771115177329, 2281.4524514116615, 2427.9317100475823, 2465.2973902437807, 2467.1241709193246, 2342.227065068523, 2384.463495713468, 2406.290144407404, 2444.6577479152934, 2453.58289090855, 2463.802895768334, 2474.059857254241, 2478.033566908898, 2522.8990840366364, 2533.3160046787357, 2274.726153354127, 2306.3081075677396, 2505.2734706934966, 2508.3352911478473, 2518.0053878717895, 2459.323685986368, 2470.295965649781, 2478.3060742991993, 2484.329231107609, 2488.4525404411, 8965.148310910454, 9006.45961242321, 9014.59434325457, 9021.14299141587, 9041.502717350542, 5462.453754624546, 5611.691356975365, 5615.989121958046, 5628.662280263197, 5635.070213414781, 3139.8744050237965, 3579.4093974494176, 3650.5619325680823, 3708.9443658344876, 3720.497732806091, 1045.9110975567087, 1055.9155267578576, 1056.9312994655322, 1056.978860422795, 1060.0406631998055, 12263.93868030663, 12438.253704777742, 12448.688782780413, 12481.875181248253, 12496.437660305308, 4848.17581011229, 4894.608431325485, 4958.950410495849, 4972.129877271463, 5012.949870501248, 10290.3825770454, 10356.275060745675, 10374.533146008296, 10385.428801415994, 10397.376157430579, 5577.9442205577425, 5578.191162281447, 5589.161625756088, 5598.272224610774, 5602.6918519481005, 4446.26636604963, 4927.605791536668, 5014.2979982802435, 5024.447310795809, 5030.748462576857, 3531.9293614127573, 4103.958960410418, 4104.363823607286, 4211.599898009746, 4238.258304796648, 1354.9187048777105, 1364.522417154008, 1370.095736813698, 1379.827521559805, 1382.3641125082374, 901.4906577783531, 921.6820197032014, 941.1012483078644, 945.664289177346, 969.2100937735722, 5930.555208359304, 5995.0, 6022.427869352405, 6083.178770865965, 6156.003122249934, 467.70768269831353, 470.407286818611, 475.74309872668374, 481.30691803803114, 483.3185208855567, 3789.5073640426567, 3900.083480382108, 3929.9214015719526, 3934.6458818706456, 4038.030872590557, 10432.426216558162, 10587.0, 10647.520861561094, 10737.302075365076, 11052.336859788278, 10550.525226364833, 10579.57681692739, 10620.09729173029, 10654.360738355723, 10663.093637040784, 8211.302039326723, 8492.150784921581, 8519.95740021296, 8522.70170544028, 8594.054653988056, 4959.404871415453, 5751.45361190703, 5945.910811337747, 5967.343592204941, 6117.082437634391, 9472.0, 9597.328187026842, 9623.615055397706, 9648.75878103053, 9694.466804325548, 9417.340786144903, 9760.804783904425, 9923.65267215644, 9941.0, 10077.949610252195, 6927.930720692729, 7482.850342993219, 7614.505057171266, 7643.082830060428, 7729.613519323899, 8341.332693384637, 8369.288610468178, 8378.162183781817, 8476.15238476172, 8599.828003440021, 7377.4098072155175, 7493.962530187314, 7526.027219248475, 7605.277498637621, 7657.310842024244, 7408.777736667908, 7445.664945077377, 7480.0649918760155, 7545.094588649397, 7554.093508778982, 7083.2208457068655, 7097.645117744195, 7124.679389427592, 7131.928680713127, 7142.285771422816, 4791.712497250176, 4855.975720121377, 4878.853634390974, 4919.926201106915, 4959.057779021974, 4332.740035597874, 4680.251159814414, 4911.165101932608, 4997.725125118153, 5130.4100028497205], "value": 4583.415744072864, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.6122375596796, 329.3725453012012, 335.5671184172418, 337.5679130712687, 340.90625078103506, 6965.756198533052, 7003.614801185933, 7021.876499760033, 7095.822604434892, 7101.289871012896, 5556.333240011204, 6936.271691472399, 6951.478639102075, 6954.96522517388, 6980.127484064492, 3890.6498415142632, 4875.926861097087, 5035.320231768701, 5042.294078828967, 5053.6715113517685, 4969.453360130401, 5027.723475208862, 5039.72281524516, 5066.1387564114, 5071.797128114871, 4964.907720301528, 4973.278874563186, 4982.153033984231, 4990.4261009983775, 4995.150824359867, 4963.329950456697, 4964.950350496485, 4982.676126051795, 4983.302337672729, 5040.395152581714, 3956.6636835868985, 4327.3725309830215, 4335.826566937319, 4338.8047537860875, 4359.585839345257, 6394.433363825892, 6608.207015158164, 6649.534532582721, 6680.465562755016, 6699.799006029827, 5969.403059694039, 6017.518598512109, 6023.427774361428, 6028.487578555828, 6049.667268300242, 5930.614510056833, 7417.0, 7419.777406677808, 7434.293742094493, 7438.7726025205775, 4587.472440669332, 4882.853514394574, 4885.14509960759, 4896.853094407174, 4910.386201724785, 7493.1757506673675, 7837.568933708644, 7840.13758486566, 7876.369890408753, 7885.645145968445, 4933.45731969483, 4949.529794669501, 4969.875753106129, 4971.527704868032, 4978.90042199154, 5070.847874563769, 5071.721055341992, 5075.87310317245, 5075.974620126875, 5077.0, 5969.701514924236, 5982.611130276518, 5999.940000600025, 6030.944584697748, 6041.818745437644, 6643.236027856762, 6879.931200687929, 7463.253674632602, 7487.1389790173735, 7494.325510704063, 1613.4836852207416, 1739.3912130754136, 1770.4334612924, 1776.7068433708553, 1778.9466316010542, 1052.4737631184407, 1056.434807378049, 1069.8876617955002, 1069.9465026748787, 1072.0887245840972, 6727.798166055026, 6872.244053154149, 6890.069840571458, 6896.551724138016, 6912.755703973233, 7541.585212813348, 7634.847303053908, 7675.347595454337, 7694.192109828499, 7717.0, 6869.244383117853, 6969.0, 6976.860462790716, 7024.2273349931465, 7025.437964962791, 4088.100617864065, 4127.09203975125, 4152.294110001307, 4155.272827255279, 4155.646770024521, 8183.304419124322, 8199.631016604268, 8211.794705132419, 8221.671133154727, 8250.876236856451, 7786.922130778733, 8055.516668999879, 8072.273495385326, 8076.152004039609, 8087.959560202161, 8090.0, 8150.592470376458, 8165.877511837327, 8188.836223275382, 8190.631421586043, 6694.263631000488, 6871.900495920629, 7130.648595160266, 7469.663865125974, 7821.530708157528, 6183.628982261079, 6698.799036028927, 7158.38936239342, 7676.34751046145, 7683.039620047494, 7202.783916482514, 7544.943707880791, 8155.429119961545, 8162.428629995843, 8173.386995975445, 3856.9035774105873, 4777.570018698334, 4784.114938736345, 4799.088173247072, 4803.183458811941, 7628.35159011468, 7680.3471704905705, 7719.652615632198, 7736.497127686683, 7785.182555831782, 6007.939920600738, 7449.47853650261, 7458.73894413693, 7471.9626401867645, 7500.512466689648, 5985.610935289366, 7226.277372262732, 7459.179490255959, 7470.8879366810625, 7550.885751989452, 6242.719077641426, 7229.240929702516, 7254.637268136466, 7314.232005639544, 7337.0, 7212.567245965259, 7432.479726419315, 7432.516886402366, 7443.441741869273, 7470.589117598584, 7009.088818453569, 7267.854642907218, 7296.854062918605, 7302.926970730225, 7348.669309881175], "value": 5372.2013873570695, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.3190729502256, 676.2865177238014, 710.541700603111, 745.1319213116719, 769.9576523291219, 14546.418143274257, 14567.344469498872, 14729.042612230198, 14818.481353152642, 15046.247687615616, 13578.728425431485, 13578.932105339483, 13598.456061757543, 13605.93197034016, 15326.923365383158, 932.5011119051309, 938.3290946972913, 943.9811203775955, 944.0087907696925, 948.8624149498319, 910.3945875992457, 920.4385324951774, 922.916937475627, 926.106307413346, 926.8841394825647, 926.9849514781304, 946.2997381937352, 961.9182369498566, 974.4591751577872, 980.2550061952896, 874.4097734029568, 898.3486971945352, 971.3686104032365, 978.7797745507276, 981.470006196653, 725.5646612032738, 728.0608015659792, 728.191707205002, 730.1566690472513, 733.4096052677593, 13632.727345453135, 13852.891768658483, 15209.011414258039, 15257.771133433007, 15286.541403757905, 12416.0, 12440.81338779919, 12661.987041036695, 12704.809427858498, 12782.680432989157, 9885.802283954352, 10141.746456338577, 10216.13162881156, 10228.07947284748, 10232.334898231591, 3444.225049363873, 3485.4423292273113, 3496.388132076902, 3551.4140166872435, 3572.8034958077556, 83256.58371708103, 84686.72969905456, 85415.57292213499, 85570.0, 85677.57161214216, 8856.38005339633, 9167.862482062774, 9358.204552612968, 9369.90630093704, 9437.245020398352, 20479.590408191754, 20816.583668326548, 20834.47913802137, 21004.579908401745, 21047.0, 7379.298966598165, 7414.406847452191, 7502.437317201232, 7518.360939320219, 7632.580208088609, 4042.130941847517, 4068.2270368629866, 4089.3661482470266, 4100.220958017967, 4135.56576559463, 2805.368792021779, 3009.8344591047703, 3230.5315729219133, 3610.783352998776, 3648.3250598638806, 559.7537083683167, 655.6459511863636, 661.632793799446, 665.4842497064814, 669.7488441834312, 535.6946540471971, 588.1325045557768, 592.1916583863082, 593.7506247376112, 616.9043798211285, 8072.071711753224, 8160.428769986044, 8211.58942052895, 8390.496570205807, 8441.366897482714, 481.32614339924385, 555.6915911669063, 592.0064257983919, 597.2862429396915, 612.8682333298362, 3750.4186851038135, 3909.276783795007, 3934.7639141651593, 3940.842366305316, 4111.650509706648, 92753.0, 94773.0, 96006.51996739971, 96105.0, 96260.0, 72700.0, 72857.0, 75792.62103689557, 76216.61891690506, 76387.85418218731, 70994.9350759739, 71581.0, 71703.6414817933, 72382.63808681029, 73838.63080684563, 6366.9681651591445, 7767.300942915164, 7861.921380786119, 7886.605669716377, 8222.876656850272, 48049.75975120102, 48902.75548622234, 49259.26111108408, 49676.50323496719, 49808.750956244985, 65545.0, 69213.0, 69472.95790563247, 69794.0, 70434.29565704483, 9745.707628771148, 9981.500924953869, 9987.60049598008, 10021.649242276486, 10488.05607495329, 10746.677599672023, 10823.783524329312, 10970.945145274223, 11020.724481888017, 11067.280626759235, 10319.400572253327, 10447.791044178923, 10570.577176912837, 10657.573697052341, 10750.301230419998, 9348.392354496937, 9422.481763503074, 9533.761655958378, 9677.516124193902, 9682.56428460735, 10131.240156988402, 10191.54138063774, 10274.383536987805, 10330.380177189392, 11145.442727863736, 8704.042555319036, 8906.643734250558, 9153.816923661623, 9243.76890577714, 9247.39891907024, 9713.125818676353, 9757.0, 9788.559514821707, 9805.950970245103, 9814.558344874355], "value": 6780.7732856853445, "unit": "score"}], "name": "dromaeo_css", "value": 7391.99188642791, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 119.0, 108.0, 114.0, 118.0, 117.0, 107.0, 118.0, 115.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 147.0, 132.0, 194.0, 152.0, 167.0, 140.0, 123.0, 172.0, 127.0], "value": 151.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 194.0, 196.0, 204.0, 199.0, 197.0, 196.0, 192.0, 202.0, 193.0], "value": 196.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 81.0, 74.0, 142.0, 57.0, 56.0, 57.0, 63.0, 127.0, 56.0], "value": 78.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 83.0, 131.0, 79.0, 82.0, 89.0, 123.0, 84.0, 80.0, 121.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 87.0, 105.0, 112.0, 84.0, 87.0, 85.0, 107.0, 131.0], "value": 97.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 94.0, 93.0, 90.0, 149.0, 117.0, 97.0, 151.0, 152.0, 95.0], "value": 113.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 97.0, 92.0, 90.0, 89.0, 91.0, 87.0, 131.0, 119.0], "value": 109.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 66.0, 65.0, 66.0, 69.0, 66.0, 68.0, 73.0, 76.0], "value": 67.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 72.0, 72.0, 72.0, 77.0, 62.0, 79.0, 101.0, 58.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 73.0, 105.0, 107.0, 69.0, 78.0, 75.0, 92.0, 103.0, 109.0], "value": 89.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 138.0, 151.0, 129.0, 128.0, 131.0, 131.0, 144.0, 198.0, 176.0], "value": 145.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 232.0, 159.0, 218.0, 207.0, 168.0, 170.0, 181.0, 188.0, 227.0], "value": 194.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 97.0, 101.0, 99.0, 68.0, 68.0, 75.0, 99.0, 89.0, 68.0], "value": 83.5, "unit": "score"}], "name": "kraken", "value": 1609.3, "alertThreshold": 2.0}]} 07:18:44 INFO - Return code: 0 07:18:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:18:44 ERROR - # TBPL SUCCESS # 07:18:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:18:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:18:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:18:44 INFO - 2016-05-28 07:18:44.872 screenresolution[1683:10844] starting screenresolution argv=screenresolution get 07:18:44 INFO - 2016-05-28 07:18:44.875 screenresolution[1683:10844] Display 0: 1600x1200x32@60 07:18:44 INFO - 2016-05-28 07:18:44.880 screenresolution[1684:10847] starting screenresolution argv=screenresolution list 07:18:44 INFO - Available Modes on Display 0 07:18:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:18:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:18:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:18:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:18:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:18:45 INFO - Intel Iris: 07:18:45 INFO - Chipset Model: Intel Iris 07:18:45 INFO - Type: GPU 07:18:45 INFO - Bus: Built-In 07:18:45 INFO - VRAM (Dynamic, Max): 1536 MB 07:18:45 INFO - Vendor: Intel (0x8086) 07:18:45 INFO - Device ID: 0x0a2e 07:18:45 INFO - Revision ID: 0x0009 07:18:45 INFO - Displays: 07:18:45 INFO - Display: 07:18:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:18:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:18:45 INFO - Display Serial Number: 1600x1200 60 07:18:45 INFO - Main Display: Yes 07:18:45 INFO - Mirror: Off 07:18:45 INFO - Online: Yes 07:18:45 INFO - Rotation: Supported 07:18:45 INFO - Return code: 0 07:18:45 INFO - Running post-action listener: _resource_record_post_action 07:18:45 INFO - Running post-run listener: _resource_record_post_run 07:18:46 INFO - Total resource usage - Wall time: 1204s; CPU: 53.0%; Read bytes: 32611840; Write bytes: 657003520; Read time: 321; Write time: 1926 07:18:46 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 346855936; Write bytes: 346507264; Read time: 26548; Write time: 657 07:18:46 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 31149568; Write bytes: 300538880; Read time: 305; Write time: 1235 07:18:46 INFO - Running post-run listener: _upload_blobber_files 07:18:46 INFO - Blob upload gear active. 07:18:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:18:46 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 07:18:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:18:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:18:46 INFO - (blobuploader) - INFO - Open directory for files ... 07:18:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:18:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:18:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:18:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:18:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:18:47 INFO - (blobuploader) - INFO - Done attempting. 07:18:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:18:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:18:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:18:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:18:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:18:48 INFO - (blobuploader) - INFO - Done attempting. 07:18:48 INFO - (blobuploader) - INFO - Iteration through files over. 07:18:48 INFO - Return code: 0 07:18:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:18:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:18:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93f7987ee945f04342b49176776f1f2a3554b28fef17c2e468fa13be5ad3357bd3075678dfb2e7b5a38522bc10259db25898e913eb775f65b6cfaeacabe52eff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ec128b92d5f013fbee3e46d1a1528db511c24683d6866b3a2286cfbc09d01206b401d332a9023bff800d705ab0dd47a8d057026e968596d041bfc904653e6043"} 07:18:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:18:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:18:48 INFO - Contents: 07:18:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93f7987ee945f04342b49176776f1f2a3554b28fef17c2e468fa13be5ad3357bd3075678dfb2e7b5a38522bc10259db25898e913eb775f65b6cfaeacabe52eff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ec128b92d5f013fbee3e46d1a1528db511c24683d6866b3a2286cfbc09d01206b401d332a9023bff800d705ab0dd47a8d057026e968596d041bfc904653e6043"} 07:18:48 INFO - Running post-run listener: copy_logs_to_upload_dir 07:18:48 INFO - Copying logs to upload dir... 07:18:48 INFO - mkdir: /builds/slave/test/build/upload/logs 07:18:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1291.916375 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2016-05-28 07:18:48.700915) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 07:18:48.704415) ========= 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.rkKWUJifQ4/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.5hEmXgfcoP/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93f7987ee945f04342b49176776f1f2a3554b28fef17c2e468fa13be5ad3357bd3075678dfb2e7b5a38522bc10259db25898e913eb775f65b6cfaeacabe52eff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ec128b92d5f013fbee3e46d1a1528db511c24683d6866b3a2286cfbc09d01206b401d332a9023bff800d705ab0dd47a8d057026e968596d041bfc904653e6043"} build_url:https://queue.taskcluster.net/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011181 build_url: 'https://queue.taskcluster.net/v1/task/BYiz5xYvRjegPCl27VEMYg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/93f7987ee945f04342b49176776f1f2a3554b28fef17c2e468fa13be5ad3357bd3075678dfb2e7b5a38522bc10259db25898e913eb775f65b6cfaeacabe52eff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ec128b92d5f013fbee3e46d1a1528db511c24683d6866b3a2286cfbc09d01206b401d332a9023bff800d705ab0dd47a8d057026e968596d041bfc904653e6043"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 07:18:48.735801) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 07:18:48.736120) ========= 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.rkKWUJifQ4/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.5hEmXgfcoP/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.005205 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 07:18:48.784748) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 07:18:48.785064) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 07:18:48.785385) ========= ========= Total master_lag: 0.18 =========