builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0143 starttime: 1464651357.42 results: success (0) buildid: 20160526140250 builduid: 01574422c30242cc92a6c0b32dab29da revision: 2ee4473c729acb2ba7dc723e7affe79ce14bff85 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 16:35:57.415599) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 16:35:57.416000) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 16:35:57.416311) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 16:35:57.706839) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:35:57.707355) ========= 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.nUK1c5mLTD/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.gY0igXShkN/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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-30 16:35:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 28.6M=0s 2016-05-30 16:35:58 (28.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.567673 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:35:58.301181) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:35:58.301500) ========= 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.nUK1c5mLTD/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.gY0igXShkN/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.028076 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:35:58.350185) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 16:35:58.350548) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2ee4473c729acb2ba7dc723e7affe79ce14bff85 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2ee4473c729acb2ba7dc723e7affe79ce14bff85 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nUK1c5mLTD/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.gY0igXShkN/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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-30 16:35:58,431 truncating revision to first 12 chars 2016-05-30 16:35:58,431 Setting DEBUG logging. 2016-05-30 16:35:58,432 attempt 1/10 2016-05-30 16:35:58,432 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2ee4473c729a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 16:35:59,612 unpacking tar archive at: mozilla-beta-2ee4473c729a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.462908 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 16:35:59.836658) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 16:35:59.837333) ========= script_repo_revision: 2ee4473c729acb2ba7dc723e7affe79ce14bff85 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 16:35:59.838090) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 16:35:59.838409) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 16:35:59.857880) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 42 secs) (at 2016-05-30 16:35:59.858188) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nUK1c5mLTD/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.gY0igXShkN/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 16:36:00 INFO - MultiFileLogger online at 20160530 16:36:00 in /builds/slave/test 16:36:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 16:36:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:36:00 INFO - {'append_to_log': False, 16:36:00 INFO - 'base_work_dir': '/builds/slave/test', 16:36:00 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:36:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:36:00 INFO - 'branch': 'Mozilla-Beta', 16:36:00 INFO - 'buildbot_json_path': 'buildprops.json', 16:36:00 INFO - 'config_files': ('talos/mac_config.py',), 16:36:00 INFO - 'default_actions': ('clobber', 16:36:00 INFO - 'read-buildbot-config', 16:36:00 INFO - 'download-and-extract', 16:36:00 INFO - 'populate-webroot', 16:36:00 INFO - 'create-virtualenv', 16:36:00 INFO - 'install', 16:36:00 INFO - 'run-tests'), 16:36:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:36:00 INFO - 'download_minidump_stackwalk': True, 16:36:00 INFO - 'download_symbols': 'ondemand', 16:36:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:36:00 INFO - 'tooltool.py': '/tools/tooltool.py', 16:36:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:36:00 INFO - '/tools/misc-python/virtualenv.py')}, 16:36:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:36:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:36:00 INFO - 'installer_path': 'installer.exe', 16:36:00 INFO - 'log_level': 'info', 16:36:00 INFO - 'log_name': 'talos', 16:36:00 INFO - 'log_to_console': True, 16:36:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:36:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:36:00 INFO - 'opt_config_files': (), 16:36:00 INFO - 'pip_index': False, 16:36:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:36:00 INFO - 'cmd': ('bash', 16:36:00 INFO - '-c', 16:36:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:36:00 INFO - 'enabled': True, 16:36:00 INFO - 'halt_on_failure': False, 16:36:00 INFO - 'name': 'check_screen_resolution'},), 16:36:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:36:00 INFO - 'cmd': ('bash', 16:36:00 INFO - '-c', 16:36:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:36:00 INFO - 'enabled': True, 16:36:00 INFO - 'halt_on_failure': False, 16:36:00 INFO - 'name': 'check_screen_resolution'},), 16:36:00 INFO - 'run_cmd_checks_enabled': True, 16:36:00 INFO - 'sps_profile': False, 16:36:00 INFO - 'sps_profile_interval': 0, 16:36:00 INFO - 'suite': 'dromaeojs-e10s', 16:36:00 INFO - 'system_bits': '32', 16:36:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:36:00 INFO - 'title': 't-yosemite-r7-0143', 16:36:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:36:00 INFO - 'use_talos_json': True, 16:36:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:36:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:36:00 INFO - 'work_dir': 'build'} 16:36:00 INFO - ##### 16:36:00 INFO - ##### Running clobber step. 16:36:00 INFO - ##### 16:36:00 INFO - Running pre-action listener: _resource_record_pre_action 16:36:00 INFO - Running main action method: clobber 16:36:00 INFO - rmtree: /builds/slave/test/build 16:36:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:36:01 INFO - Running post-action listener: _resource_record_post_action 16:36:01 INFO - ##### 16:36:01 INFO - ##### Running read-buildbot-config step. 16:36:01 INFO - ##### 16:36:01 INFO - Running pre-action listener: _resource_record_pre_action 16:36:01 INFO - Running main action method: read_buildbot_config 16:36:01 INFO - Using buildbot properties: 16:36:01 INFO - { 16:36:01 INFO - "project": "", 16:36:01 INFO - "product": "firefox", 16:36:01 INFO - "script_repo_revision": "production", 16:36:01 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 16:36:01 INFO - "repository": "", 16:36:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 16:36:01 INFO - "buildid": "20160526140250", 16:36:01 INFO - "pgo_build": "False", 16:36:01 INFO - "basedir": "/builds/slave/test", 16:36:01 INFO - "buildnumber": 9, 16:36:01 INFO - "slavename": "t-yosemite-r7-0143", 16:36:01 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 16:36:01 INFO - "platform": "yosemite_r7", 16:36:01 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 16:36:01 INFO - "branch": "mozilla-beta", 16:36:01 INFO - "repo_path": "releases/mozilla-beta", 16:36:01 INFO - "revision": "2ee4473c729acb2ba7dc723e7affe79ce14bff85", 16:36:01 INFO - "stage_platform": "macosx64", 16:36:01 INFO - "builduid": "01574422c30242cc92a6c0b32dab29da", 16:36:01 INFO - "slavebuilddir": "test" 16:36:01 INFO - } 16:36:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 16:36:01 INFO - Running post-action listener: _resource_record_post_action 16:36:01 INFO - ##### 16:36:01 INFO - ##### Running download-and-extract step. 16:36:01 INFO - ##### 16:36:01 INFO - Running pre-action listener: _resource_record_pre_action 16:36:01 INFO - Running main action method: download_and_extract 16:36:01 INFO - mkdir: /builds/slave/test/build/tests 16:36:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:01 INFO - https://queue.taskcluster.net/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:36:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 16:36:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 16:36:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 16:36:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 16:36:25 INFO - Downloaded 1241 bytes. 16:36:25 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 16:36:25 INFO - Using the following test package requirements: 16:36:25 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 16:36:25 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 16:36:25 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 16:36:25 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 16:36:25 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 16:36:25 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 16:36:25 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 16:36:25 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 16:36:25 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 16:36:25 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 16:36:25 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 16:36:25 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 16:36:25 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 16:36:25 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 16:36:25 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 16:36:25 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 16:36:25 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 16:36:25 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 16:36:25 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 16:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:25 INFO - https://queue.taskcluster.net/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:36:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 16:36:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 16:36:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 16:36:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 16:36:52 INFO - Downloaded 17816878 bytes. 16:36:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:36:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:36:55 INFO - Return code: 0 16:36:55 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 16:36:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:55 INFO - https://queue.taskcluster.net/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:36:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 16:36:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 16:36:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 16:36:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 16:36:57 INFO - Downloaded 17816878 bytes. 16:36:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:36:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:37:01 INFO - Return code: 0 16:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:01 INFO - https://queue.taskcluster.net/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:37:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 16:37:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 16:37:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 16:37:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 16:37:02 INFO - Downloaded 10845194 bytes. 16:37:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:37:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 16:37:03 INFO - Return code: 0 16:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:03 INFO - https://queue.taskcluster.net/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 16:37:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 16:37:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 16:37:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 16:37:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 16:37:05 INFO - Downloaded 88466316 bytes. 16:37:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 16:37:05 INFO - mkdir: /builds/slave/test/properties 16:37:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:37:05 INFO - Writing to file /builds/slave/test/properties/build_url 16:37:05 INFO - Contents: 16:37:05 INFO - build_url:https://queue.taskcluster.net/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 16:37:06 INFO - Running post-action listener: _resource_record_post_action 16:37:06 INFO - Running post-action listener: set_extra_try_arguments 16:37:06 INFO - ##### 16:37:06 INFO - ##### Running populate-webroot step. 16:37:06 INFO - ##### 16:37:06 INFO - Running pre-action listener: _resource_record_pre_action 16:37:06 INFO - Running main action method: populate_webroot 16:37:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:37:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:37:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:37:06 INFO - '--tppagecycles', 16:37:06 INFO - '7'], 16:37:06 INFO - 'tests': ['tsvgm']}}, 16:37:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:37:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:37:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:37:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:37:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:37:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:37:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:37:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:06 INFO - 'talos_options': ['--e10s'], 16:37:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:37:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:06 INFO - 'tests': ['damp', 'tps']}, 16:37:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:06 INFO - 'talos_options': ['--e10s'], 16:37:06 INFO - 'tests': ['damp', 'tps']}, 16:37:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:37:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:37:06 INFO - 'other': {'tests': ['a11yr', 16:37:06 INFO - 'ts_paint', 16:37:06 INFO - 'tpaint', 16:37:06 INFO - 'sessionrestore', 16:37:06 INFO - 'sessionrestore_no_auto_restore', 16:37:06 INFO - 'tabpaint']}, 16:37:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:37:06 INFO - 'tests': ['a11yr', 16:37:06 INFO - 'ts_paint', 16:37:06 INFO - 'tpaint', 16:37:06 INFO - 'sessionrestore', 16:37:06 INFO - 'sessionrestore_no_auto_restore', 16:37:06 INFO - 'tabpaint']}, 16:37:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:37:06 INFO - 'tests': ['a11yr', 16:37:06 INFO - 'ts_paint', 16:37:06 INFO - 'tpaint', 16:37:06 INFO - 'sessionrestore', 16:37:06 INFO - 'sessionrestore_no_auto_restore', 16:37:06 INFO - 'tabpaint']}, 16:37:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:37:06 INFO - 'tests': ['a11yr', 16:37:06 INFO - 'ts_paint', 16:37:06 INFO - 'tpaint', 16:37:06 INFO - 'sessionrestore', 16:37:06 INFO - 'sessionrestore_no_auto_restore', 16:37:06 INFO - 'tabpaint']}, 16:37:06 INFO - 'other_l64': {'tests': ['a11yr', 16:37:06 INFO - 'ts_paint', 16:37:06 INFO - 'tpaint', 16:37:06 INFO - 'sessionrestore', 16:37:06 INFO - 'sessionrestore_no_auto_restore', 16:37:06 INFO - 'tabpaint']}, 16:37:06 INFO - 'other_nol64': {'tests': ['a11yr', 16:37:06 INFO - 'ts_paint', 16:37:06 INFO - 'tpaint', 16:37:06 INFO - 'sessionrestore', 16:37:06 INFO - 'sessionrestore_no_auto_restore', 16:37:06 INFO - 'tabpaint']}, 16:37:06 INFO - 'svgr': {'tests': ['tsvgx', 16:37:06 INFO - 'tsvgr_opacity', 16:37:06 INFO - 'tart', 16:37:06 INFO - 'tscrollx', 16:37:06 INFO - 'cart']}, 16:37:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:37:06 INFO - 'tests': ['tsvgx', 16:37:06 INFO - 'tsvgr_opacity', 16:37:06 INFO - 'tart', 16:37:06 INFO - 'tscrollx', 16:37:06 INFO - 'cart']}, 16:37:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:06 INFO - 'tests': ['tp5o']}, 16:37:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:06 INFO - 'talos_options': ['--e10s'], 16:37:06 INFO - 'tests': ['tp5o']}, 16:37:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:06 INFO - 'talos_options': ['--xperf_path', 16:37:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:37:06 INFO - 'tests': ['tp5n']}, 16:37:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:06 INFO - 'talos_options': ['--e10s', 16:37:06 INFO - '--xperf_path', 16:37:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:37:06 INFO - 'tests': ['tp5n']}}, 16:37:06 INFO - 'talos.zip': {'path': '', 16:37:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:37:06 INFO - Running post-action listener: _resource_record_post_action 16:37:06 INFO - ##### 16:37:06 INFO - ##### Running create-virtualenv step. 16:37:06 INFO - ##### 16:37:06 INFO - Running pre-action listener: _resource_record_pre_action 16:37:06 INFO - Running main action method: create_virtualenv 16:37:06 INFO - Creating virtualenv /builds/slave/test/build/venv 16:37:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:37:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:37:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:37:06 INFO - Using real prefix '/tools/python27' 16:37:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:37:07 INFO - Installing distribute.............................................................................................................................................................................................done. 16:37:10 INFO - Installing pip.................done. 16:37:10 INFO - Return code: 0 16:37:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:10 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 0x10c9b2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb83bc59f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c856d30>, '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 0x10c6badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84db20>, '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.nUK1c5mLTD/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.gY0igXShkN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:37:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:37:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:37:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nUK1c5mLTD/Render', 16:37:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:10 INFO - 'HOME': '/Users/cltbld', 16:37:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:10 INFO - 'LOGNAME': 'cltbld', 16:37:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:10 INFO - 'MOZ_NO_REMOTE': '1', 16:37:10 INFO - 'NO_EM_RESTART': '1', 16:37:10 INFO - 'PAGER': '/bin/cat', 16:37:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:10 INFO - 'PWD': '/builds/slave/test', 16:37:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:10 INFO - 'SHELL': '/bin/bash', 16:37:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gY0igXShkN/Listeners', 16:37:10 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 16:37:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:10 INFO - 'USER': 'cltbld', 16:37:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:10 INFO - 'XPC_FLAGS': '0x0', 16:37:10 INFO - 'XPC_SERVICE_NAME': '0', 16:37:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:37:10 INFO - Cleaning up... 16:37:10 INFO - Return code: 0 16:37:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:10 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 0x10c9b2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb83bc59f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c856d30>, '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 0x10c6badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84db20>, '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.nUK1c5mLTD/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.gY0igXShkN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:37:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:37:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:37:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nUK1c5mLTD/Render', 16:37:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:10 INFO - 'HOME': '/Users/cltbld', 16:37:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:10 INFO - 'LOGNAME': 'cltbld', 16:37:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:10 INFO - 'MOZ_NO_REMOTE': '1', 16:37:10 INFO - 'NO_EM_RESTART': '1', 16:37:10 INFO - 'PAGER': '/bin/cat', 16:37:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:10 INFO - 'PWD': '/builds/slave/test', 16:37:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:10 INFO - 'SHELL': '/bin/bash', 16:37:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gY0igXShkN/Listeners', 16:37:10 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 16:37:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:10 INFO - 'USER': 'cltbld', 16:37:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:10 INFO - 'XPC_FLAGS': '0x0', 16:37:10 INFO - 'XPC_SERVICE_NAME': '0', 16:37:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:11 INFO - Downloading/unpacking psutil>=0.7.1 16:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:37:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:37:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:37:14 INFO - Installing collected packages: psutil 16:37:14 INFO - Running setup.py install for psutil 16:37:14 INFO - building 'psutil._psutil_osx' extension 16:37:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 16:37:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 16:37:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 16:37:14 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 16:37:15 INFO - building 'psutil._psutil_posix' extension 16:37:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 16:37:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:37:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:37:15 INFO - ^ 16:37:15 INFO - 1 warning generated. 16:37:15 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 16:37:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:37:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:37:15 INFO - Successfully installed psutil 16:37:15 INFO - Cleaning up... 16:37:15 INFO - Return code: 0 16:37:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c9b2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb83bc59f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c856d30>, '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 0x10c6badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84db20>, '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.nUK1c5mLTD/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.gY0igXShkN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:37:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:37:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:37:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nUK1c5mLTD/Render', 16:37:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:15 INFO - 'HOME': '/Users/cltbld', 16:37:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:15 INFO - 'LOGNAME': 'cltbld', 16:37:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:15 INFO - 'MOZ_NO_REMOTE': '1', 16:37:15 INFO - 'NO_EM_RESTART': '1', 16:37:15 INFO - 'PAGER': '/bin/cat', 16:37:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:15 INFO - 'PWD': '/builds/slave/test', 16:37:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:15 INFO - 'SHELL': '/bin/bash', 16:37:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gY0igXShkN/Listeners', 16:37:15 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 16:37:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:15 INFO - 'USER': 'cltbld', 16:37:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:15 INFO - 'XPC_FLAGS': '0x0', 16:37:15 INFO - 'XPC_SERVICE_NAME': '0', 16:37:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:37:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:37:18 INFO - Installing collected packages: mozsystemmonitor 16:37:18 INFO - Running setup.py install for mozsystemmonitor 16:37:18 INFO - Successfully installed mozsystemmonitor 16:37:18 INFO - Cleaning up... 16:37:18 INFO - Return code: 0 16:37:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb83bc59f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c856d30>, '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 0x10c6badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84db20>, '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.nUK1c5mLTD/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.gY0igXShkN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:37:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:37:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:37:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nUK1c5mLTD/Render', 16:37:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:18 INFO - 'HOME': '/Users/cltbld', 16:37:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:18 INFO - 'LOGNAME': 'cltbld', 16:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:18 INFO - 'MOZ_NO_REMOTE': '1', 16:37:18 INFO - 'NO_EM_RESTART': '1', 16:37:18 INFO - 'PAGER': '/bin/cat', 16:37:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:18 INFO - 'PWD': '/builds/slave/test', 16:37:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:18 INFO - 'SHELL': '/bin/bash', 16:37:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gY0igXShkN/Listeners', 16:37:18 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 16:37:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:18 INFO - 'USER': 'cltbld', 16:37:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:18 INFO - 'XPC_FLAGS': '0x0', 16:37:18 INFO - 'XPC_SERVICE_NAME': '0', 16:37:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:18 INFO - Downloading/unpacking blobuploader==1.2.4 16:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:21 INFO - Downloading blobuploader-1.2.4.tar.gz 16:37:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:37:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:37:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:22 INFO - Downloading docopt-0.6.1.tar.gz 16:37:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:37:22 INFO - Installing collected packages: blobuploader, requests, docopt 16:37:22 INFO - Running setup.py install for blobuploader 16:37:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:37:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:37:22 INFO - Running setup.py install for requests 16:37:22 INFO - Running setup.py install for docopt 16:37:23 INFO - Successfully installed blobuploader requests docopt 16:37:23 INFO - Cleaning up... 16:37:23 INFO - Return code: 0 16:37:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb83bc59f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c856d30>, '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 0x10c6badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84db20>, '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.nUK1c5mLTD/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.gY0igXShkN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:37:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:37:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:37:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nUK1c5mLTD/Render', 16:37:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:23 INFO - 'HOME': '/Users/cltbld', 16:37:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:23 INFO - 'LOGNAME': 'cltbld', 16:37:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:23 INFO - 'MOZ_NO_REMOTE': '1', 16:37:23 INFO - 'NO_EM_RESTART': '1', 16:37:23 INFO - 'PAGER': '/bin/cat', 16:37:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:23 INFO - 'PWD': '/builds/slave/test', 16:37:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:23 INFO - 'SHELL': '/bin/bash', 16:37:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gY0igXShkN/Listeners', 16:37:23 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 16:37:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:23 INFO - 'USER': 'cltbld', 16:37:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:23 INFO - 'XPC_FLAGS': '0x0', 16:37:23 INFO - 'XPC_SERVICE_NAME': '0', 16:37:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:37:23 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-rEhYDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:37:23 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-npegLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:37:23 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-M87ZOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:37:23 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-YXXveE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:37:23 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-GseNXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:37:23 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-iFqDey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:37:24 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-wUxszA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:37:24 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-NNWszl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:37:24 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-Vf9alT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:37:24 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-T9YquX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:37:24 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-OVL3UB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:37:24 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-D98cxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:37:24 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-4gvbhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:37:24 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-zr6Gn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:24 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-ubojtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:37:25 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-eSpEih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:37:25 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-DBdSwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:37:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:37:25 INFO - Running setup.py install for manifestparser 16:37:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:37:25 INFO - Running setup.py install for mozcrash 16:37:25 INFO - Running setup.py install for mozdebug 16:37:25 INFO - Running setup.py install for mozdevice 16:37:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:37:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:37:25 INFO - Running setup.py install for mozfile 16:37:25 INFO - Running setup.py install for mozhttpd 16:37:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:37:26 INFO - Running setup.py install for mozinfo 16:37:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:37:26 INFO - Running setup.py install for mozInstall 16:37:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:37:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:37:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:37:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:37:26 INFO - Running setup.py install for mozleak 16:37:26 INFO - Running setup.py install for mozlog 16:37:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:37:26 INFO - Running setup.py install for moznetwork 16:37:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:37:26 INFO - Running setup.py install for mozprocess 16:37:27 INFO - Running setup.py install for mozprofile 16:37:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:37:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:37:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:37:27 INFO - Running setup.py install for mozrunner 16:37:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:37:27 INFO - Running setup.py install for mozscreenshot 16:37:27 INFO - Running setup.py install for moztest 16:37:27 INFO - Running setup.py install for mozversion 16:37:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:37:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:37:27 INFO - Cleaning up... 16:37:27 INFO - Return code: 0 16:37:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:27 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 0x10c9b2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb83bc59f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c856d30>, '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 0x10c6badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84db20>, '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.nUK1c5mLTD/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.gY0igXShkN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:37:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:37:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:37:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nUK1c5mLTD/Render', 16:37:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:27 INFO - 'HOME': '/Users/cltbld', 16:37:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:27 INFO - 'LOGNAME': 'cltbld', 16:37:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:27 INFO - 'MOZ_NO_REMOTE': '1', 16:37:27 INFO - 'NO_EM_RESTART': '1', 16:37:27 INFO - 'PAGER': '/bin/cat', 16:37:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:27 INFO - 'PWD': '/builds/slave/test', 16:37:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:27 INFO - 'SHELL': '/bin/bash', 16:37:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gY0igXShkN/Listeners', 16:37:27 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 16:37:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:27 INFO - 'USER': 'cltbld', 16:37:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:27 INFO - 'XPC_FLAGS': '0x0', 16:37:27 INFO - 'XPC_SERVICE_NAME': '0', 16:37:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:37:28 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-EUZ4vK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:37:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:37:28 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-YmZjnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:37:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:37:28 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-Do6Lbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:37:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:37:28 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-kE2QCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:37:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:37:28 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-ykrLk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:37:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:37:28 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-9qnJjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:37:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:37:28 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-65l37Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:37:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:37:28 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-SOMXDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:37:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:37:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:37:28 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-yBFSkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:37:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:37:29 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-ohv5NL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:37:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:37:29 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-Vhg98J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:37:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:37:29 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-9mXnZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:37:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:37:29 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-__Q6if-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:37:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:37:29 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-c8XfyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:37:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:29 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-ZGc0r5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:37:29 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-kYj_Ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:37:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:37:29 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-dj2ER1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:37:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:37:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:37:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:37:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:37:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:37:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:37:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:32 INFO - Downloading blessings-1.6.tar.gz 16:37:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:37:32 INFO - Installing collected packages: blessings 16:37:32 INFO - Running setup.py install for blessings 16:37:32 INFO - Successfully installed blessings 16:37:32 INFO - Cleaning up... 16:37:32 INFO - Return code: 0 16:37:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:37:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:37:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:37:32 INFO - Reading from file tmpfile_stdout 16:37:32 INFO - Current package versions: 16:37:32 INFO - blessings == 1.6 16:37:32 INFO - blobuploader == 1.2.4 16:37:32 INFO - docopt == 0.6.1 16:37:32 INFO - manifestparser == 1.1 16:37:32 INFO - mozInstall == 1.12 16:37:32 INFO - mozcrash == 0.17 16:37:32 INFO - mozdebug == 0.1 16:37:32 INFO - mozdevice == 0.48 16:37:32 INFO - mozfile == 1.2 16:37:32 INFO - mozhttpd == 0.7 16:37:32 INFO - mozinfo == 0.9 16:37:32 INFO - mozleak == 0.1 16:37:32 INFO - mozlog == 3.1 16:37:32 INFO - moznetwork == 0.27 16:37:32 INFO - mozprocess == 0.22 16:37:32 INFO - mozprofile == 0.28 16:37:32 INFO - mozrunner == 6.11 16:37:32 INFO - mozscreenshot == 0.1 16:37:32 INFO - mozsystemmonitor == 0.0 16:37:32 INFO - moztest == 0.7 16:37:32 INFO - mozversion == 1.4 16:37:32 INFO - psutil == 3.1.1 16:37:32 INFO - requests == 1.2.3 16:37:32 INFO - wsgiref == 0.1.2 16:37:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37: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')]} 16:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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')]} 16:37:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:32 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 0x10c9b2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb83bc59f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c856d30>, '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 0x10c6badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84db20>, '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.nUK1c5mLTD/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.gY0igXShkN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:37:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:37:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:37:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nUK1c5mLTD/Render', 16:37:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:32 INFO - 'HOME': '/Users/cltbld', 16:37:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:32 INFO - 'LOGNAME': 'cltbld', 16:37:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:32 INFO - 'MOZ_NO_REMOTE': '1', 16:37:32 INFO - 'NO_EM_RESTART': '1', 16:37:32 INFO - 'PAGER': '/bin/cat', 16:37:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:32 INFO - 'PWD': '/builds/slave/test', 16:37:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:32 INFO - 'SHELL': '/bin/bash', 16:37:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gY0igXShkN/Listeners', 16:37:32 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 16:37:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:32 INFO - 'USER': 'cltbld', 16:37:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:32 INFO - 'XPC_FLAGS': '0x0', 16:37:32 INFO - 'XPC_SERVICE_NAME': '0', 16:37:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:37:33 INFO - Cleaning up... 16:37:33 INFO - Return code: 0 16:37:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:33 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 0x10c9b2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb83bc59f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c856d30>, '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 0x10c6badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84db20>, '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.nUK1c5mLTD/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.gY0igXShkN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:37:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:37:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:37:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nUK1c5mLTD/Render', 16:37:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:33 INFO - 'HOME': '/Users/cltbld', 16:37:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:33 INFO - 'LOGNAME': 'cltbld', 16:37:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:33 INFO - 'MOZ_NO_REMOTE': '1', 16:37:33 INFO - 'NO_EM_RESTART': '1', 16:37:33 INFO - 'PAGER': '/bin/cat', 16:37:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:33 INFO - 'PWD': '/builds/slave/test', 16:37:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:33 INFO - 'SHELL': '/bin/bash', 16:37:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gY0igXShkN/Listeners', 16:37:33 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 16:37:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:33 INFO - 'USER': 'cltbld', 16:37:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:33 INFO - 'XPC_FLAGS': '0x0', 16:37:33 INFO - 'XPC_SERVICE_NAME': '0', 16:37:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:33 INFO - Downloading/unpacking jsonschema 16:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:37:35 INFO - Downloading/unpacking functools32 (from jsonschema) 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37:36 INFO - Downloading functools32-3.2.3-2.tar.gz 16:37:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:37:36 INFO - warning: no files found matching '*.txt' 16:37:36 INFO - no previously-included directories found matching 'build' 16:37:36 INFO - no previously-included directories found matching 'dist' 16:37:36 INFO - no previously-included directories found matching '.git*' 16:37:36 INFO - Installing collected packages: jsonschema, functools32 16:37:36 INFO - Running setup.py install for functools32 16:37:36 INFO - warning: no files found matching '*.txt' 16:37:36 INFO - no previously-included directories found matching 'build' 16:37:36 INFO - no previously-included directories found matching 'dist' 16:37:36 INFO - no previously-included directories found matching '.git*' 16:37:36 INFO - Successfully installed jsonschema functools32 16:37:36 INFO - Cleaning up... 16:37:36 INFO - Return code: 0 16:37:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9b94c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb83bc59f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c856d30>, '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 0x10c6badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84db20>, '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.nUK1c5mLTD/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.gY0igXShkN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:37:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:37:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:37:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nUK1c5mLTD/Render', 16:37:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:37:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:37:36 INFO - 'HOME': '/Users/cltbld', 16:37:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:37:36 INFO - 'LOGNAME': 'cltbld', 16:37:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:36 INFO - 'MOZ_NO_REMOTE': '1', 16:37:36 INFO - 'NO_EM_RESTART': '1', 16:37:36 INFO - 'PAGER': '/bin/cat', 16:37:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:37:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:36 INFO - 'PWD': '/builds/slave/test', 16:37:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:37:36 INFO - 'SHELL': '/bin/bash', 16:37:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gY0igXShkN/Listeners', 16:37:36 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 16:37:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:37:36 INFO - 'USER': 'cltbld', 16:37:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:37:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:37:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:36 INFO - 'XPC_FLAGS': '0x0', 16:37:36 INFO - 'XPC_SERVICE_NAME': '0', 16:37:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:37:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:36 INFO - Downloading/unpacking flake8 16:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:37:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:37:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37: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 16:37:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:37:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:37:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:37:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:37:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:37:40 INFO - no previously-included directories found matching 'docs/_build' 16:37:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:37:40 INFO - Running setup.py install for pep8 16:37:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:37:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:37:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:37:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:37:40 INFO - no previously-included directories found matching 'docs/_build' 16:37:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:37:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:37:41 INFO - Cleaning up... 16:37:41 INFO - Return code: 0 16:37:41 INFO - Running post-action listener: _resource_record_post_action 16:37:41 INFO - Running post-action listener: _start_resource_monitoring 16:37:41 INFO - Starting resource monitoring. 16:37:41 INFO - ##### 16:37:41 INFO - ##### Running install step. 16:37:41 INFO - ##### 16:37:41 INFO - Running pre-action listener: _resource_record_pre_action 16:37:41 INFO - Running main action method: install 16:37:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:37:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:37:41 INFO - Reading from file tmpfile_stdout 16:37:41 INFO - Detecting whether we're running mozinstall >=1.0... 16:37:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:37:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:37:41 INFO - Reading from file tmpfile_stdout 16:37:41 INFO - Output received: 16:37:41 INFO - Usage: mozinstall [options] installer 16:37:41 INFO - Options: 16:37:41 INFO - -h, --help show this help message and exit 16:37:41 INFO - -d DEST, --destination=DEST 16:37:41 INFO - Directory to install application into. [default: 16:37:41 INFO - "/builds/slave/test"] 16:37:41 INFO - --app=APP Application being installed. [default: firefox] 16:37:41 INFO - mkdir: /builds/slave/test/build/application 16:37:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:37:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 16:38:04 INFO - Reading from file tmpfile_stdout 16:38:04 INFO - Output received: 16:38:04 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 16:38:04 INFO - Running post-action listener: _resource_record_post_action 16:38:04 INFO - ##### 16:38:04 INFO - ##### Running run-tests step. 16:38:04 INFO - ##### 16:38:04 INFO - Running pre-action listener: _resource_record_pre_action 16:38:04 INFO - Running main action method: run_tests 16:38:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:38:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:38:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:38:04 INFO - 2016-05-30 16:38:04.512 screenresolution[1652:8407] starting screenresolution argv=screenresolution get 16:38:04 INFO - 2016-05-30 16:38:04.515 screenresolution[1652:8407] Display 0: 1600x1200x32@60 16:38:04 INFO - 2016-05-30 16:38:04.521 screenresolution[1653:8410] starting screenresolution argv=screenresolution list 16:38:04 INFO - Available Modes on Display 0 16:38:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:38:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:38:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:38:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:38:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:38:04 INFO - Intel Iris: 16:38:04 INFO - Chipset Model: Intel Iris 16:38:04 INFO - Type: GPU 16:38:04 INFO - Bus: Built-In 16:38:04 INFO - VRAM (Dynamic, Max): 1536 MB 16:38:04 INFO - Vendor: Intel (0x8086) 16:38:04 INFO - Device ID: 0x0a2e 16:38:04 INFO - Revision ID: 0x0009 16:38:04 INFO - Displays: 16:38:04 INFO - Display: 16:38:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:38:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:38:04 INFO - Display Serial Number: 1600x1200 60 16:38:04 INFO - Main Display: Yes 16:38:04 INFO - Mirror: Off 16:38:04 INFO - Online: Yes 16:38:04 INFO - Rotation: Supported 16:38:04 INFO - Return code: 0 16:38:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:38:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:38:04 INFO - Python 2.7.3 16:38:04 INFO - Return code: 0 16:38:04 INFO - grabbing minidump binary from tooltool 16:38:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:04 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 0x10c856d30>, '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 0x10c6badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c84db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:38:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:38:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 16:38:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:38:04 INFO - Return code: 0 16:38:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:38:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:38:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:38:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:38:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:38:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:38:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:38:06 INFO - Return code: 0 16:38:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0143', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:38:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0143 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:38:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nUK1c5mLTD/Render', 16:38:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:38:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:38:06 INFO - 'HOME': '/Users/cltbld', 16:38:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:38:06 INFO - 'LOGNAME': 'cltbld', 16:38:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:38:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:38:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:06 INFO - 'MOZ_NO_REMOTE': '1', 16:38:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:38:06 INFO - 'NO_EM_RESTART': '1', 16:38:06 INFO - 'PAGER': '/bin/cat', 16:38:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:38:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:06 INFO - 'PWD': '/builds/slave/test', 16:38:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:38:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:38:06 INFO - 'SHELL': '/bin/bash', 16:38:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gY0igXShkN/Listeners', 16:38:06 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 16:38:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:38:06 INFO - 'USER': 'cltbld', 16:38:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:38:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:38:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:06 INFO - 'XPC_FLAGS': '0x0', 16:38:06 INFO - 'XPC_SERVICE_NAME': '0', 16:38:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:38:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0143', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:38:06 INFO - mozversion application_buildid: 20160526140250 16:38:06 INFO - mozversion application_changeset: 2ee4473c729acb2ba7dc723e7affe79ce14bff85 16:38:06 INFO - mozversion application_display_name: Firefox 16:38:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:38:06 INFO - mozversion application_name: Firefox 16:38:06 INFO - mozversion application_remotingname: firefox 16:38:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:38:06 INFO - mozversion application_vendor: Mozilla 16:38:06 INFO - mozversion application_version: 47.0 16:38:06 INFO - mozversion platform_buildid: 20160526140250 16:38:06 INFO - mozversion platform_changeset: 2ee4473c729acb2ba7dc723e7affe79ce14bff85 16:38:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:38:06 INFO - mozversion platform_version: 47.0 16:38:06 INFO - using testdate: 1464651486 16:38:06 INFO - actual date: 1464651486 16:38:06 INFO - starting webserver on 'localhost:49290' 16:38:06 INFO - SUITE-START | Running 2 tests 16:38:06 INFO - TEST-START | dromaeo_css 16:38:06 INFO - operating with platform_type : mac_ 16:38:06 INFO - Initialising browser for dromaeo_css test... 16:38:06 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpd03Fn0/profile http://localhost:49290/getInfo.html) 16:38:09 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 16:38:09 INFO - PROCESS | 1671 | colorDepth:24 16:38:09 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 16:38:09 INFO - PROCESS | 1671 | __metrics 16:38:09 ERROR - PROCESS | 1671 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 16:38:10 INFO - TEST-INFO | 1671: exit 0 16:38:10 INFO - Browser initialized. 16:38:10 INFO - Running cycle 1/1 for dromaeo_css test... 16:38:10 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpd03Fn0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:38:21 INFO - PROCESS | 1676 | RSS: Main: 167886848 16:38:21 INFO - PROCESS | 1676 | 16:39:11 INFO - PROCESS | 1676 | 1464651551553 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:41:22 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49290/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49290/tests/dromaeo/cssquery-ext.html) 16:41:24 INFO - PROCESS | 1676 | RSS: Main: 178606080 16:41:24 INFO - PROCESS | 1676 | 16:44:26 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49290/tests/dromaeo/cssquery-ext.html (next: http://localhost:49290/tests/dromaeo/cssquery-jquery.html) 16:44:26 INFO - PROCESS | 1676 | RSS: Main: 189841408 16:44:26 INFO - PROCESS | 1676 | 16:47:28 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49290/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49290/tests/dromaeo/cssquery-mootools.html) 16:47:29 INFO - PROCESS | 1676 | RSS: Main: 191655936 16:47:29 INFO - PROCESS | 1676 | 16:50:30 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49290/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49290/tests/dromaeo/cssquery-prototype.html) 16:50:31 INFO - PROCESS | 1676 | RSS: Main: 195067904 16:50:31 INFO - PROCESS | 1676 | 16:53:34 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49290/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49290/tests/dromaeo/cssquery-yui.html) 16:53:34 INFO - PROCESS | 1676 | RSS: Main: 195031040 16:53:34 INFO - PROCESS | 1676 | 16:56:36 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49290/tests/dromaeo/cssquery-yui.html (next: http://localhost:49290/tests/dromaeo/cssquery-dojo.html) 16:56:37 INFO - PROCESS | 1676 | RSS: Main: 199892992 16:56:37 INFO - PROCESS | 1676 | 16:56:37 INFO - PROCESS | 1676 | __start_tp_report 16:56:37 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 16:56:37 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 16:56:37 INFO - PROCESS | 1676 | |i|pagename|runs| 16:56:37 INFO - PROCESS | 1676 | |0;dojo.html;3673.981630091849;3698.9445158322646;3702.3335799556085;3754.511913451251;3762.7742335459866;5958.927393069252;5990.371011043843;5997.190379298793;6021.8193454196335;6024.849378765533;5924.703764811753;5951.434613711701;6035.2757669079665;6039.063945088507;6040.214772079624;5352.384475785276;5407.675539467645;5431.2396264522995;5486.423925487826;5509.090999985017;5358.223057656657;5471.72641367932;5482.409022090537;5482.698451585161;5503.3120859892515;5392.325959255093;5435.83692489224;5440.102383106782;5447.972760136214;5456.563474922016;5493.697846618435;5495.917561236584;5522.392536820947;5531.695756733378;5546.4453554644415;5319.388270348921;5408.594355423359;5438.102713052342;5480.068388373946;5513.531349835269;5462.890742185134;5531;5742.626729262626;5802.62282951611;6105.32841387447;6195.411435913581;6278.874422511524;6284.497240220771;6288.654124023177;6302.149209856657;5630.521405680522;5717.256756621613;6274.623522588659;6299.5275354348605;6310.6213627182515;6005.909911351377;6006.3693312201585;6068.937935861207;6111.602745821508;6120.510359171256;6456.031595260749;6485.70814313357;6497.837554061186;6500.252470965805;6504.772332968323;6203.720832562545;6286.937130628727;6299;6306.527010474233;6308.495320374359;6222;6314.273858506239;6334.208223972004;6364.936350636434;6400.455961243253;6267.341929097471;6276;6307.085472606538;6312.684365781693;6320.367963203643;5277.23480095384;5565.749541270652;6287.622742635456;6325.620462772248;6332.588381755263;4996.475370086161;5028.572571331405;5097.8725531861255;5116.744162791845;5150.742462876841;4132.028973191298;4408.096340250241;4610.170169369546;4632.2819962905805;4641.907161856811;6011.098335249748;6192.164057852132;6202.224721909762;6202.875942481125;6233;6345.270293916259;6351.047342898602;6368.29948705642;6387.201599800025;6387.329330420332;6108.847278818065;6109.266887973472;6111.786087487006;6117.174181485442;6156.445919867144;5497.945020549823;5572.804951826666;5585.860353491195;5598.580106491948;5640.984622767941;6460.289368169498;6511.967440162769;6536.052272420472;6570.5400621956005;6579.440747536513;6353.4599559038;6371.39471750183;6389.041643753474;6398.744050237939;6405.807825765234;6469.867773139587;6523.64119973387;6539.084528165966;6610.6694665267505;6636.037774522763;6225.750969961151;6281.780137695158;6309.305976342691;6335.58818676803;6350.1744773181035;6310.905336420049;6321.020241862519;6332.873342533031;6337.493000559852;6354.93645063562;6154.922888494585;6167.814965551041;6300.117983482408;6309.652969086745;6323.620582765049;5883.2057672213705;6228.564000520101;6281.340459251713;6282.277538083179;6295.811125666238;5309.283246761638;5695.800646977336;6109.938900611115;6184.876302474016;6246.937530624636;6131.478824299985;6156.26124865019;6238.407351301619;6261.311255761953;6282.780102696566;6255;6282.434580887742;6285.277193122849;6286.214223222098;6311.684415779285 16:56:37 INFO - PROCESS | 1676 | |1;ext.html;437.55588078100715;580.9506191973682;629.98257813631;635.3709827271001;670.5473805181502;34146.48780268298;40383.79808100963;40530.7973460133;40811;40818.59181408185;42287.154256914844;42567.57432425675;42699.359509607384;42874.92812679685;43224.13551728964;9696.563654635524;9903.50482475877;9907.752306192368;9921.702348929508;9936.105750482455;9984.600615975389;10061.39631622105;10070.69787906364;10110.898891011106;10124.987501249852;8581.52801595912;10066.647667331645;10102.646407375743;10138.49307534624;10158.28891977562;9953.552090155961;9991.250656200778;10056;10082.092611664912;10095.596176152945;8300.916990830076;9820;9950.253730970206;9962.302638815287;9976.201903847676;40773.184536309105;40801.79599102015;41015.97460063492;41678.58321416807;42555.36166957498;3281.1797050737314;3362.5628668272966;3404.557407537029;3420.350133474632;3438.0889064397707;28837.56743648847;29802.254943626365;29853.70146298531;29964.250893727614;30160.69839301601;2759.075709637274;2762.875670594828;2793.8323700577826;2794.2315863137596;2821.647294088239;502958;511294;514087.85912141146;514576.9999999963;515929;49780;50600.493995060315;79629.20370796218;80375.7943630846;80896;49561.25658115131;49741.50258497441;50488.242676359885;50553.49446505561;50746;16666.6666666666;16713.331466741194;16724.49826505207;17033.97796132236;17171.88382755117;13627;13656.24890631005;13661.112027718167;13794.93102534481;13819.861801382058;15990.920045399931;16064.036157830567;16165.515034548982;16678.249478773483;16684.33262669504;7192.82017949545;7235.638218089074;7235.746748863765;7298.56208627484;7312.744053958086;1002.3785253143097;1087.4015197659428;1101.983470247947;1131.1459847814847;1138.7893239750672;27482.862585686944;28214.43571128566;29230;32664.183395414828;33503.497447538306;1098.7527806243531;1130.423484023154;1155.5551112821456;1166.7899778039864;1247.6381849263794;15320.616984575474;15740.68518629621;15796.289166987513;16027.599310017109;16153.515394538183;581178;683076;683589;686375;691223;66229;66297.66851165713;66874.66562667156;66986.99519507114;67217;1541.5991842120904;1543.1821134798574;1559.173637971854;1576.692544953746;1583.1688363608966;27628.447431051667;30505.694943050286;31363;31892.5216121763;32060.358792824478;56386.718066409405;57200;57219.42780572141;57551.136732949875;57574.42425575691;432550;432680;433751;436704.8164759156;438865;36200.63799362078;36773.44839827351;36886.446703298934;37020.07449813669;37475.25049499049;48084.519154808004;48953;49263.01473970429;49542;50061.99876002387;39993.00017499586;40260.59739402686;40484.79757601193;40659;40968.79515602403;39669.80165099156;39674.40488392619;39812.800935996296;40022.799886000386;40762.79618602007;39287.01782455347;39450.60549394469;40291.99270018273;40324.79837600793;40496.595034049285;33362.66637333693;35299.941001769985;35443.64556354507;35778.463323049655;35829;25626;25740.356491087874;25777.742222578283;26216.606750899133;26281.60577591376 16:56:37 INFO - PROCESS | 1676 | |2;jquery.html;328.1533643200542;361.0810487309796;361.72508893241144;373.58345444829024;375.5943580932593;17433;20343.796562034375;20884.582308353823;22476.775232247674;22578;20898.05958731857;21130.366089017316;21353.893230533864;21400.14399424021;21769.891150544227;5327.307450031491;5529.447055294479;5556.111022236423;5556.305461817273;5557.638753481031;5449.237106805051;5775.249217601727;6034.637921724689;6047.637141771485;6049.153118563405;5164.4060932992625;5778.3643799182055;6024.246969128859;6036.96981515094;6079.878402431948;5859.2675915510345;5879.67661778602;5937.287525496947;5945.732442040118;5968.67172305523;4677.438707355105;6000.33996260411;6016.75932962681;6030.577859549833;6197.977333739973;13746.96897732664;13813.963952703587;13902.443902243898;13998.30008499571;14205;2319.4665226997718;2320;2673.4920365130756;2806.3264816443907;2815.591739197805;9960.003999600054;9992.550335234931;10148.289619726622;10219.978002199794;10376.584936602527;1718.269735362466;1751.2907272554507;1756.7364895265684;1772.3885259585422;1838.2003828334584;78142.43715125666;112364;113583;113734.72530549343;118120;11505.942470287762;11750.94124529372;11762.126172998152;11819;11952.402379881145;14533.927330363493;14700.485483008257;14759;14795;14834.480793172188;7539.1563562406;8536.189062039097;9176.174144327042;9303.534823258946;9416.05839416053;8035.674113771279;9525;9586.842960333868;9768.21854251658;9786.580945762824;3806.733528652968;4575.473820510684;4602.516735742765;4618.145643056046;4627.236505976476;1778.2797966823457;1925.6052509235574;1931.3529967461059;1967.085305333027;1973.6250112478583;891.4294851295176;1030.4744580263969;1064.5688496159069;1075.1291453922347;1089.1504626391427;17343.437017648117;20240.089195985922;20792.58414831725;21092.261770837948;21537.67693484599;937.1425145991478;973.1728031173446;976.3848775271675;1014.6347314966606;1040.6565833275001;10258.43578603169;10942.398168100672;11166.441677916071;11193.552257909756;11196.608118715805;558581;562927;567291;639523.6047639557;643071;96122;128451;133934.3303283497;134316.99999999805;135497;1055.9894401055892;1059.1315121600214;1087.260662749338;1099.3513826842202;1110.189561620022;15041.849581504044;18815.776974496614;18954.24183032663;19136;19293.903530482257;38986.4152037714;54396.45603544072;54694.45305546893;57397.71301143467;57871.4212857866;75882.62058689671;78611;78892.4221515578;79056.60471697604;80305;7987.600619969095;8177.509349439053;8191.508509489449;8271.875921861298;8282.751517454486;9461.621535138518;13069;13372.398242078934;13395.598132056053;13420.993425492932;9569.377990430878;11091.223614347242;11297.43512824372;11469.426528673699;11631.127665424958;10992.670219893416;11374.60188893418;11595.652130436101;11815.40922953866;11843.52625894989;11630.94184529072;11677.88322116802;12079.396030198279;12130.939345303217;12165.452554634885;7950.165232650488;8086.43394962347;8208.958955205424;8249.422540422353;8427.325813934993;8451.915480845113;11275.718107047389;11627.47676354583;11764.470598823245;11873.703157420789 16:56:37 INFO - PROCESS | 1676 | |3;mootools.html;1676.6898123847088;1685.7050016247158;2021.2925476083374;2078.4803799050246;2103.9579208415844;8259.050209225941;8936.91063089369;8974.282057435406;9187.494687792168;9215.078492150782;8925;8961.417507861985;8996.055414181516;9020.143086406797;9105.590248438819;2530.633058206559;2545.2745967399296;2550.298667866333;2559.11710459892;2562.397836508419;2483.4039830440656;2551.4514379408424;2558.897644094234;2565.3458368116103;2567.2169988153605;2518.6851643544555;2532.442862570241;2551.4259291659323;2555.7316481769426;2573.626824110512;2519.4709111086604;2539.669842920418;2544.3257536752776;2547.592385218356;2574.45936353366;2155.3533939817994;2197.3517812245427;2535.809814263919;2549.987250063756;2586.185351614254;7652.770416887447;9133;9178.036306187822;9195.770105747342;9214.308926830514;5192.92210616841;5532.921080389326;5652.63257888236;5777;5781.566382521286;3200.695933886277;3642.7814331140216;3720.330340538702;3740.7942563159286;3768.9434658480145;1075.150631001508;1093.2675107677876;1093.775775965925;1098.2586753941057;1099.6096385783092;10374.273800833944;12117.151799374047;12294.631161065183;12532.310722910237;12554.560590379293;5006.64953453262;5013.373328333958;5072.923906141411;5092.465291144451;5150.871228219325;10473.9476302618;10511.632092876713;10546.314489558154;10553.84169237462;10568.365898046142;5598.496135347838;5668.744906479218;5689.91891540606;5721.885562288814;5733.741981610838;4629.884252893705;4991.650584459126;5035.546800787946;5071.06185355703;5081.28861959326;4052.5091654511466;4091.5499295077516;4105.322621767435;4144.7513149211145;4165.520965088993;1201.2912381694666;1359.6736783172166;1382.5299398204659;1386.1544457880684;1391.172252509755;1229.2317301686446;1397.9790303145462;1423.9747381885027;1482.9925850370894;1493.57433131557;8395.496270223806;8544.444611100258;8572.27135693473;8595.828083438297;8608.655653773903;535.651169621206;538.9056915039853;540.1600511205114;543.1337017457149;544.1918750655274;6325.7785977491485;6354.936450635527;6405.167328247391;6414.198225221848;6486.318936511692;10832.133429325793;11160.609378671708;11214.439278036065;11290.604828830952;11320.943395283135;10657.520411581498;10870.912908709066;10905.945470272598;11075.224734268684;11094;7348.191698913115;8564.95717521421;8683.392162548687;8762.299016078827;8777.956110219537;7936;8097.352211823158;8112.391570632344;8123.79690507742;8213.425060245725;9674.661386851427;9818.950905245429;9888.406695598287;9969;10191.796164076824;10020.498975051363;10181.440020798631;10192.898071019195;10322.793544129225;10405.271630985759;7624;7704.30661240491;7711.730089446843;7770.14528401864;7786;8360.707375241838;8389.66441342364;8438.029626593021;8473.406861519634;8499.362547809063;7601.7719468416035;7801.570913599807;7812.765617031499;7865.764027079197;7870.409719271192;7510;7566.508176968699;7594.696212151452;7733.845323093619;7736.303732664087;7906;7929.762107136795;7930.048394192734;7946.404019698662;8009.599520024092;7053.294670532906;7111.608861512666;7195.640217989185;7204.855902882018;7228.20489746117;7289.744858929912;7316.158641756266;7330.853382932418;7334.486585938933;7363.447741419308 16:56:37 INFO - PROCESS | 1676 | |4;prototype.html;332.65403979860946;332.758749906318;333.6996702967329;334.22459893048136;340.68316465686917;6931.306869313066;6968.815301398762;6968.96515517423;6976.093107895979;6990.196127445345;6897.413719833808;6915.827104322394;6932.549384290018;6943.444524438046;6970.198427180876;4915.697340204831;5048.545630893219;5127.307813445174;5130.4356520782685;5209.400918894319;5118.846434606968;5119.206522988943;5126.564242039412;5144.922826157611;5145.81989630363;4091.3862920561855;5075.365579302587;5089.949100509003;5095.159298715707;5144.0740666679985;5125.154349532341;5126.436092029874;5141.897162056756;5145.897082058356;5151.562117220041;4450.26570615848;4457.465104187519;4457.8439754608435;4476.753778542179;4483.856616562788;6467.676616169173;6554.8361290968105;6713.731450741964;6783.355581219826;6820.727170913157;6010;6032.8190154295;6059.606125601822;6060.30306514752;6070.271567411939;7383.6677349519405;7416.258374162595;7419.8145046374275;7425.591592462412;7458.03045604068;4947.50524947506;4952.702837829742;4955.801767929279;4960.975195124038;4970.801167953277;7026.894596581106;7810.765677029698;7827.96086019572;7833;7869.331106855924;4899.412070551557;4968.329275547827;4977.477364876709;4993.650444468925;5014.423341315795;4393.450818647669;4833.864041950139;5083.440821509631;5087.465816089258;5103.668261562986;5934.910976335358;5955.731992060368;5956.225690660273;5959.046552551571;6019.157317975487;7419.6661150248365;7431.516951398142;7437.1447283562;7479.962600187073;7491.213422590658;1703.7103692372327;1751.6146447781468;1751.7985431675265;1771.6545273671768;1799.145405932198;1142.2404101272562;1143.6226045404997;1156.6587856582328;1158.8435561199299;1162.4536467860091;6932.584044957319;6989.860202796017;6993.580385176906;6997.335253150943;7027.648617569101;7659.4255430841795;7682.1549629540705;7692.423068269902;7693.961530192313;7718.035245594301;6964.756233531802;6969.477289203229;6997.1253593300835;7011.719531218796;7024.297570243037;3326.2515933914674;3734.215814678948;4050.4531888195306;4062.659322423593;4081.9795901020307;7894.881576776353;8036.557989310527;8130.19508269646;8139.22677345663;8145.755627331189;8004.599770011476;8012.879806802903;8022;8027.996500437445;8041.954545908994;8085.676572937016;8134.877976830352;8139.348852091937;8147;8154.959225203836;7472.887906681295;7730.806729831799;7791.4935529190425;7796.10344810354;7837.451378403685;6520.445762110274;7615.6953721850505;7640.656170472231;7650.426218033558;7660.233976602518;8113.391495637733;8128.187181281824;8143.778433234826;8154.429189956646;8159.836803263783;5064.265681476239;5080.618953578571;5092.770825312796;5107.463716309734;5109.948900510947;5883.441073098049;6291.276503202191;7724.266194711493;7733.4973226740085;7760.495567788075;7433.553986760811;7454.403647708062;7478.70085196586;7522.097348318237;7531.058617672791;7454.440916931143;7462.216467270859;7482;7486.5508069516;7490.438217133627;6990.951357296446;7284.453665975179;7299.124105107421;7299.781006569811;7330.926690733238;7397.593132377771;7452;7466.290702383265;7470.140933792466;7477.289657482531;6062.696865156637;6233.283172435228;7209.95455658937;7285.7814265572115;7327.37717294036 16:56:37 INFO - PROCESS | 1676 | |5;yui.html;651.8240075179699;670.2827974067746;692.6277499563994;714.8105751975727;755.4862693368509;13364.933175334121;13979.30103494825;14944.252787360629;15009.849901500982;15091.39634414622;14196.71606567868;14246.358913848875;14251.572452826405;14275;14297.71404571908;802.9277365037145;941.1999800169853;953.7043516509904;970.0687340153461;977.6578197630807;939.0750111140521;971.0241207586402;971.1647982734843;971.480258061937;973.9561719722594;988.6737376665683;994.1301361308855;1002.2132625888679;1015.7917626886507;1023.738946568624;985.0887928665991;991.0733464210914;1011.5245834457793;1015.7308313296983;1016.547636301846;611.9173911521932;737.8745613245761;747.8354761952362;748.4498893313411;754.3964828137523;14976.17631030293;14977.925110374488;15152.696946061127;15248.161351125684;15452.381904723798;12975.935120324433;12983.156094853899;13092.738145237137;13096.934515327457;13170.60488185356;10123.371153941422;10235.488225588691;10275.743106422324;10325.070743633034;10362.378257304586;3551.5560554930635;3607.981960090183;3682.558093028827;3682.7181448839165;3698.4822124902535;82911.585442073;83067.5846620769;83208.75186872263;84293;86164.27671446536;9597.23222142227;9650.662226822027;9667.226621870373;9709.465979371062;9971.800563988825;21405.464863378227;21683.241086561895;21723.131074757148;22506.099756009902;22547.774522254567;7537.773866784005;7648.541087534766;7762.146163921964;7842.333401660922;7882.211778822187;4189.97905010473;4190.958090419118;4234.894127646833;4244.808983595745;4342.435483387139;3671.4492826076303;3703.2223233121344;3707.277080969185;3712.276106159273;3715.7398982070995;670.4100391655312;678.281022116558;679.4869873245767;690.226945820684;695.8886578147473;571.4085921071754;585.4204337705726;596.6956852005421;601.6089541797779;622.9221347331584;7642.465027448136;8037.397195210383;8247.432987732313;8379.329653627696;8447.915520844836;523.8057229516708;551.7241379310345;558.4108765252616;592;642.2164958750317;3316.817575033396;3892.416137579329;3912.8434862605177;3953.5058117735284;3955.564887862333;55495.72252138794;89881.10118898858;99847.50228746574;103864;104231.95768042223;64813.351866480734;64955.02567461492;65395;65420.34579654143;76587;65989.34010659928;67529.66235168891;67824.66087669629;69014;69633;8369.623366948625;8611.913880861111;8645.049044604963;8655.913440865763;8721.520316382659;48126;49909.500904990484;50097.747556311384;50587.49412505975;51457;67717;68743.65628171827;69001;69638.65180674064;70358;10221.488925553544;10802.405867677353;10897.67306980792;10926.175838456476;11459.31244125355;11838.112141589243;12066.457009434422;12144.392780361124;12154.696132596755;12576.30830304342;11467.770644587228;11544.653660390202;11626.069914406658;11724.120690948042;11864.99147572466;11671.708207294885;11675.941620292184;11752.35362055061;12013.219140756173;12133;11331.830022549833;11362;11482.138839586898;11789.469473873525;11806.232594881305;9637.951810240904;9798.069183427562;9876.308658393844;9897.208223342259;10242.948785256027;9880;9885.752856178653;9942.950285248528;9945.701628951143;9992.750181245236 16:56:37 INFO - PROCESS | 1676 | __end_tp_report 16:56:37 INFO - PROCESS | 1676 | __start_cc_report 16:56:37 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,354 16:56:37 INFO - PROCESS | 1676 | __end_cc_report 16:56:37 INFO - PROCESS | 1676 | __startTimestamp1464652597086__endTimestamp 16:56:37 INFO - PROCESS | 1676 | 16:56:37 INFO - PROCESS | 1676 | ------- Summary: start ------- 16:56:37 INFO - PROCESS | 1676 | Number of tests: 6 16:56:37 INFO - PROCESS | 1676 | 16:56:37 INFO - PROCESS | 1676 | [#0] dojo.html Cycles:165 Average:5915.50 Median:6167.81 stddev:614.51 (10.0%) stddev-sans-first:590.70 16:56:37 INFO - PROCESS | 1676 | Values: 3674.0 3698.9 3702.3 3754.5 3762.8 5958.9 5990.4 5997.2 6021.8 6024.8 5924.7 5951.4 6035.3 6039.1 6040.2 5352.4 5407.7 5431.2 5486.4 5509.1 5358.2 5471.7 5482.4 5482.7 5503.3 5392.3 5435.8 5440.1 5448.0 5456.6 5493.7 5495.9 5522.4 5531.7 5546.4 5319.4 5408.6 5438.1 5480.1 5513.5 5462.9 5531.0 5742.6 5802.6 6105.3 6195.4 6278.9 6284.5 6288.7 6302.1 5630.5 5717.3 6274.6 6299.5 6310.6 6005.9 6006.4 6068.9 6111.6 6120.5 6456.0 6485.7 6497.8 6500.3 6504.8 6203.7 6286.9 6299.0 6306.5 6308.5 6222.0 6314.3 6334.2 6364.9 6400.5 6267.3 6276.0 6307.1 6312.7 6320.4 5277.2 5565.7 6287.6 6325.6 6332.6 4996.5 5028.6 5097.9 5116.7 5150.7 4132.0 4408.1 4610.2 4632.3 4641.9 6011.1 6192.2 6202.2 6202.9 6233.0 6345.3 6351.0 6368.3 6387.2 6387.3 6108.8 6109.3 6111.8 6117.2 6156.4 5497.9 5572.8 5585.9 5598.6 5641.0 6460.3 6512.0 6536.1 6570.5 6579.4 6353.5 6371.4 6389.0 6398.7 6405.8 6469.9 6523.6 6539.1 6610.7 6636.0 6225.8 6281.8 6309.3 6335.6 6350.2 6310.9 6321.0 6332.9 6337.5 6354.9 6154.9 6167.8 6300.1 6309.7 6323.6 5883.2 6228.6 6281.3 6282.3 6295.8 5309.3 5695.8 6109.9 6184.9 6246.9 6131.5 6156.3 6238.4 6261.3 6282.8 6255.0 6282.4 6285.3 6286.2 6311.7 16:56:37 INFO - PROCESS | 1676 | 16:56:37 INFO - PROCESS | 1676 | [#1] ext.html Cycles:180 Average:68491.30 Median:39743.60 stddev:145831.50 (366.9%) stddev-sans-first:146151.09 16:56:37 INFO - PROCESS | 1676 | Values: 437.6 581.0 630.0 635.4 670.5 34146.5 40383.8 40530.8 40811.0 40818.6 42287.2 42567.6 42699.4 42874.9 43224.1 9696.6 9903.5 9907.8 9921.7 9936.1 9984.6 10061.4 10070.7 10110.9 10125.0 8581.5 10066.6 10102.6 10138.5 10158.3 9953.6 9991.3 10056.0 10082.1 10095.6 8300.9 9820.0 9950.3 9962.3 9976.2 40773.2 40801.8 41016.0 41678.6 42555.4 3281.2 3362.6 3404.6 3420.4 3438.1 28837.6 29802.3 29853.7 29964.3 30160.7 2759.1 2762.9 2793.8 2794.2 2821.6 502958.0 511294.0 514087.9 514577.0 515929.0 49780.0 50600.5 79629.2 80375.8 80896.0 49561.3 49741.5 50488.2 50553.5 50746.0 16666.7 16713.3 16724.5 17034.0 17171.9 13627.0 13656.2 13661.1 13794.9 13819.9 15990.9 16064.0 16165.5 16678.2 16684.3 7192.8 7235.6 7235.7 7298.6 7312.7 1002.4 1087.4 1102.0 1131.1 1138.8 27482.9 28214.4 29230.0 32664.2 33503.5 1098.8 1130.4 1155.6 1166.8 1247.6 15320.6 15740.7 15796.3 16027.6 16153.5 581178.0 683076.0 683589.0 686375.0 691223.0 66229.0 66297.7 66874.7 66987.0 67217.0 1541.6 1543.2 1559.2 1576.7 1583.2 27628.4 30505.7 31363.0 31892.5 32060.4 56386.7 57200.0 57219.4 57551.1 57574.4 432550.0 432680.0 433751.0 436704.8 438865.0 36200.6 36773.4 36886.4 37020.1 37475.3 48084.5 48953.0 49263.0 49542.0 50062.0 39993.0 40260.6 40484.8 40659.0 40968.8 39669.8 39674.4 39812.8 40022.8 40762.8 39287.0 39450.6 40292.0 40324.8 40496.6 33362.7 35299.9 35443.6 35778.5 35829.0 25626.0 25740.4 25777.7 26216.6 26281.6 16:56:37 INFO - PROCESS | 1676 | 16:56:37 INFO - PROCESS | 1676 | [#2] jquery.html Cycles:180 Average:34331.96 Median:21653.78 stddev:99231.90 (458.3%) stddev-sans-first:99477.43 16:56:37 INFO - PROCESS | 1676 | Values: 328.2 361.1 361.7 373.6 375.6 17433.0 20343.8 20884.6 22476.8 22578.0 20898.1 21130.4 21353.9 21400.1 21769.9 5327.3 5529.4 5556.1 5556.3 5557.6 5449.2 5775.2 6034.6 6047.6 6049.2 5164.4 5778.4 6024.2 6037.0 6079.9 5859.3 5879.7 5937.3 5945.7 5968.7 4677.4 6000.3 6016.8 6030.6 6198.0 13747.0 13814.0 13902.4 13998.3 14205.0 2319.5 2320.0 2673.5 2806.3 2815.6 9960.0 9992.6 10148.3 10220.0 10376.6 1718.3 1751.3 1756.7 1772.4 1838.2 78142.4 112364.0 113583.0 113734.7 118120.0 11505.9 11750.9 11762.1 11819.0 11952.4 14533.9 14700.5 14759.0 14795.0 14834.5 7539.2 8536.2 9176.2 9303.5 9416.1 8035.7 9525.0 9586.8 9768.2 9786.6 3806.7 4575.5 4602.5 4618.1 4627.2 1778.3 1925.6 1931.4 1967.1 1973.6 891.4 1030.5 1064.6 1075.1 1089.2 17343.4 20240.1 20792.6 21092.3 21537.7 937.1 973.2 976.4 1014.6 1040.7 10258.4 10942.4 11166.4 11193.6 11196.6 558581.0 562927.0 567291.0 639523.6 643071.0 96122.0 128451.0 133934.3 134317.0 135497.0 1056.0 1059.1 1087.3 1099.4 1110.2 15041.8 18815.8 18954.2 19136.0 19293.9 38986.4 54396.5 54694.5 57397.7 57871.4 75882.6 78611.0 78892.4 79056.6 80305.0 7987.6 8177.5 8191.5 8271.9 8282.8 9461.6 13069.0 13372.4 13395.6 13421.0 9569.4 11091.2 11297.4 11469.4 11631.1 10992.7 11374.6 11595.7 11815.4 11843.5 11630.9 11677.9 12079.4 12130.9 12165.5 7950.2 8086.4 8209.0 8249.4 8427.3 8451.9 11275.7 11627.5 11764.5 11873.7 16:56:37 INFO - PROCESS | 1676 | 16:56:37 INFO - PROCESS | 1676 | [#3] mootools.html Cycles:180 Average:6246.98 Median:5171.90 stddev:3299.05 (63.8%) stddev-sans-first:3290.42 16:56:37 INFO - PROCESS | 1676 | Values: 1676.7 1685.7 2021.3 2078.5 2104.0 8259.1 8936.9 8974.3 9187.5 9215.1 8925.0 8961.4 8996.1 9020.1 9105.6 2530.6 2545.3 2550.3 2559.1 2562.4 2483.4 2551.5 2558.9 2565.3 2567.2 2518.7 2532.4 2551.4 2555.7 2573.6 2519.5 2539.7 2544.3 2547.6 2574.5 2155.4 2197.4 2535.8 2550.0 2586.2 7652.8 9133.0 9178.0 9195.8 9214.3 5192.9 5532.9 5652.6 5777.0 5781.6 3200.7 3642.8 3720.3 3740.8 3768.9 1075.2 1093.3 1093.8 1098.3 1099.6 10374.3 12117.2 12294.6 12532.3 12554.6 5006.6 5013.4 5072.9 5092.5 5150.9 10473.9 10511.6 10546.3 10553.8 10568.4 5598.5 5668.7 5689.9 5721.9 5733.7 4629.9 4991.7 5035.5 5071.1 5081.3 4052.5 4091.5 4105.3 4144.8 4165.5 1201.3 1359.7 1382.5 1386.2 1391.2 1229.2 1398.0 1424.0 1483.0 1493.6 8395.5 8544.4 8572.3 8595.8 8608.7 535.7 538.9 540.2 543.1 544.2 6325.8 6354.9 6405.2 6414.2 6486.3 10832.1 11160.6 11214.4 11290.6 11320.9 10657.5 10870.9 10905.9 11075.2 11094.0 7348.2 8565.0 8683.4 8762.3 8778.0 7936.0 8097.4 8112.4 8123.8 8213.4 9674.7 9819.0 9888.4 9969.0 10191.8 10020.5 10181.4 10192.9 10322.8 10405.3 7624.0 7704.3 7711.7 7770.1 7786.0 8360.7 8389.7 8438.0 8473.4 8499.4 7601.8 7801.6 7812.8 7865.8 7870.4 7510.0 7566.5 7594.7 7733.8 7736.3 7906.0 7929.8 7930.0 7946.4 8009.6 7053.3 7111.6 7195.6 7204.9 7228.2 7289.7 7316.2 7330.9 7334.5 7363.4 16:56:37 INFO - PROCESS | 1676 | 16:56:37 INFO - PROCESS | 1676 | [#4] prototype.html Cycles:180 Average:6099.76 Median:6954.10 stddev:1949.01 (28.0%) stddev-sans-first:1905.80 16:56:37 INFO - PROCESS | 1676 | Values: 332.7 332.8 333.7 334.2 340.7 6931.3 6968.8 6969.0 6976.1 6990.2 6897.4 6915.8 6932.5 6943.4 6970.2 4915.7 5048.5 5127.3 5130.4 5209.4 5118.8 5119.2 5126.6 5144.9 5145.8 4091.4 5075.4 5089.9 5095.2 5144.1 5125.2 5126.4 5141.9 5145.9 5151.6 4450.3 4457.5 4457.8 4476.8 4483.9 6467.7 6554.8 6713.7 6783.4 6820.7 6010.0 6032.8 6059.6 6060.3 6070.3 7383.7 7416.3 7419.8 7425.6 7458.0 4947.5 4952.7 4955.8 4961.0 4970.8 7026.9 7810.8 7828.0 7833.0 7869.3 4899.4 4968.3 4977.5 4993.7 5014.4 4393.5 4833.9 5083.4 5087.5 5103.7 5934.9 5955.7 5956.2 5959.0 6019.2 7419.7 7431.5 7437.1 7480.0 7491.2 1703.7 1751.6 1751.8 1771.7 1799.1 1142.2 1143.6 1156.7 1158.8 1162.5 6932.6 6989.9 6993.6 6997.3 7027.6 7659.4 7682.2 7692.4 7694.0 7718.0 6964.8 6969.5 6997.1 7011.7 7024.3 3326.3 3734.2 4050.5 4062.7 4082.0 7894.9 8036.6 8130.2 8139.2 8145.8 8004.6 8012.9 8022.0 8028.0 8042.0 8085.7 8134.9 8139.3 8147.0 8155.0 7472.9 7730.8 7791.5 7796.1 7837.5 6520.4 7615.7 7640.7 7650.4 7660.2 8113.4 8128.2 8143.8 8154.4 8159.8 5064.3 5080.6 5092.8 5107.5 5109.9 5883.4 6291.3 7724.3 7733.5 7760.5 7433.6 7454.4 7478.7 7522.1 7531.1 7454.4 7462.2 7482.0 7486.6 7490.4 6991.0 7284.5 7299.1 7299.8 7330.9 7397.6 7452.0 7466.3 7470.1 7477.3 6062.7 6233.3 7210.0 7285.8 7327.4 16:56:37 INFO - PROCESS | 1676 | 16:56:37 INFO - PROCESS | 1676 | [#5] yui.html Cycles:180 Average:18139.03 Median:28023.72 stddev:25271.80 (90.2%) stddev-sans-first:25308.58 16:56:37 INFO - PROCESS | 1676 | Values: 651.8 670.3 692.6 714.8 755.5 13364.9 13979.3 14944.3 15009.8 15091.4 14196.7 14246.4 14251.6 14275.0 14297.7 802.9 941.2 953.7 970.1 977.7 939.1 971.0 971.2 971.5 974.0 988.7 994.1 1002.2 1015.8 1023.7 985.1 991.1 1011.5 1015.7 1016.5 611.9 737.9 747.8 748.4 754.4 14976.2 14977.9 15152.7 15248.2 15452.4 12975.9 12983.2 13092.7 13096.9 13170.6 10123.4 10235.5 10275.7 10325.1 10362.4 3551.6 3608.0 3682.6 3682.7 3698.5 82911.6 83067.6 83208.8 84293.0 86164.3 9597.2 9650.7 9667.2 9709.5 9971.8 21405.5 21683.2 21723.1 22506.1 22547.8 7537.8 7648.5 7762.1 7842.3 7882.2 4190.0 4191.0 4234.9 4244.8 4342.4 3671.4 3703.2 3707.3 3712.3 3715.7 670.4 678.3 679.5 690.2 695.9 571.4 585.4 596.7 601.6 622.9 7642.5 8037.4 8247.4 8379.3 8447.9 523.8 551.7 558.4 592.0 642.2 3316.8 3892.4 3912.8 3953.5 3955.6 55495.7 89881.1 99847.5 103864.0 104232.0 64813.4 64955.0 65395.0 65420.3 76587.0 65989.3 67529.7 67824.7 69014.0 69633.0 8369.6 8611.9 8645.0 8655.9 8721.5 48126.0 49909.5 50097.7 50587.5 51457.0 67717.0 68743.7 69001.0 69638.7 70358.0 10221.5 10802.4 10897.7 10926.2 11459.3 11838.1 12066.5 12144.4 12154.7 12576.3 11467.8 11544.7 11626.1 11724.1 11865.0 11671.7 11675.9 11752.4 12013.2 12133.0 11331.8 11362.0 11482.1 11789.5 11806.2 9638.0 9798.1 9876.3 9897.2 10242.9 9880.0 9885.8 9943.0 9945.7 9992.8 16:56:37 INFO - PROCESS | 1676 | -------- Summary: end -------- 16:56:37 INFO - PROCESS | 1676 | 16:56:37 INFO - TEST-INFO | 1676: exit 0 16:56:37 INFO - TEST-OK | dromaeo_css | took 1111310ms 16:56:37 INFO - TEST-START | kraken 16:56:37 INFO - operating with platform_type : mac_ 16:56:37 INFO - Initialising browser for kraken test... 16:56:37 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpdztNH5/profile http://localhost:49290/getInfo.html) 16:56:40 INFO - PROCESS | 1684 | __metrics Screen width/height:1600/1200 16:56:40 INFO - PROCESS | 1684 | colorDepth:24 16:56:40 INFO - PROCESS | 1684 | Browser inner width/height: 1024/689 16:56:40 INFO - PROCESS | 1684 | __metrics 16:56:40 ERROR - PROCESS | 1684 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 16:56:40 INFO - TEST-INFO | 1684: exit 0 16:56:40 INFO - Browser initialized. 16:56:40 INFO - Running cycle 1/1 for kraken test... 16:56:40 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpdztNH5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:56:52 INFO - PROCESS | 1688 | RSS: Main: 168022016 16:56:52 INFO - PROCESS | 1688 | 16:56:55 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49290/tests/kraken/driver.html?testName=audio-beat-detection) 16:56:56 INFO - PROCESS | 1688 | RSS: Main: 180334592 16:56:56 INFO - PROCESS | 1688 | 16:56:58 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49290/tests/kraken/driver.html?testName=audio-dft) 16:56:59 INFO - PROCESS | 1688 | RSS: Main: 189075456 16:56:59 INFO - PROCESS | 1688 | 16:57:02 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49290/tests/kraken/driver.html?testName=audio-fft) 16:57:03 INFO - PROCESS | 1688 | RSS: Main: 192208896 16:57:03 INFO - PROCESS | 1688 | 16:57:05 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49290/tests/kraken/driver.html?testName=audio-oscillator) 16:57:05 INFO - PROCESS | 1688 | RSS: Main: 192610304 16:57:05 INFO - PROCESS | 1688 | 16:57:07 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49290/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:57:08 INFO - PROCESS | 1688 | RSS: Main: 194154496 16:57:08 INFO - PROCESS | 1688 | 16:57:11 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49290/tests/kraken/driver.html?testName=imaging-darkroom) 16:57:11 INFO - PROCESS | 1688 | RSS: Main: 194887680 16:57:11 INFO - PROCESS | 1688 | 16:57:14 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49290/tests/kraken/driver.html?testName=imaging-desaturate) 16:57:15 INFO - PROCESS | 1688 | RSS: Main: 194744320 16:57:15 INFO - PROCESS | 1688 | 16:57:18 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49290/tests/kraken/driver.html?testName=json-parse-financial) 16:57:18 INFO - PROCESS | 1688 | RSS: Main: 194838528 16:57:18 INFO - PROCESS | 1688 | 16:57:20 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49290/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:57:21 INFO - PROCESS | 1688 | RSS: Main: 194093056 16:57:21 INFO - PROCESS | 1688 | 16:57:23 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:57:23 INFO - PROCESS | 1688 | RSS: Main: 194183168 16:57:23 INFO - PROCESS | 1688 | 16:57:25 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:57:26 INFO - PROCESS | 1688 | RSS: Main: 194383872 16:57:26 INFO - PROCESS | 1688 | 16:57:28 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:57:29 INFO - PROCESS | 1688 | RSS: Main: 194478080 16:57:29 INFO - PROCESS | 1688 | 16:57:32 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:57:32 INFO - PROCESS | 1688 | RSS: Main: 194355200 16:57:32 INFO - PROCESS | 1688 | 16:57:34 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49290/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49290/tests/kraken/driver.html?testName=ai-astar) 16:57:34 INFO - PROCESS | 1688 | RSS: Main: 196026368 16:57:34 INFO - PROCESS | 1688 | 16:57:34 INFO - PROCESS | 1688 | __start_tp_report 16:57:34 INFO - PROCESS | 1688 | _x_x_mozilla_page_load 16:57:34 INFO - PROCESS | 1688 | _x_x_mozilla_page_load_details 16:57:34 INFO - PROCESS | 1688 | |i|pagename|runs| 16:57:34 INFO - PROCESS | 1688 | |0;ai-astar;141;157;142;116;116;127;115;115;115;115 16:57:34 INFO - PROCESS | 1688 | |1;audio-beat-detection;146;122;150;145;119;135;136;135;145;149 16:57:34 INFO - PROCESS | 1688 | |2;audio-dft;195;198;198;201;197;192;201;194;200;197 16:57:34 INFO - PROCESS | 1688 | |3;audio-fft;73;96;96;149;47;77;49;60;139;81 16:57:34 INFO - PROCESS | 1688 | |4;audio-oscillator;86;81;119;80;82;88;121;81;80;118 16:57:34 INFO - PROCESS | 1688 | |5;imaging-gaussian-blur;118;129;88;128;76;87;75;73;133;129 16:57:34 INFO - PROCESS | 1688 | |6;imaging-darkroom;99;139;149;95;94;97;98;95;122;98 16:57:34 INFO - PROCESS | 1688 | |7;imaging-desaturate;92;95;90;91;87;132;141;145;90;131 16:57:34 INFO - PROCESS | 1688 | |8;json-parse-financial;54;60;58;58;84;87;85;51;50;79 16:57:34 INFO - PROCESS | 1688 | |9;json-stringify-tinderbox;64;65;72;69;69;74;61;77;95;94 16:57:34 INFO - PROCESS | 1688 | |10;stanford-crypto-aes;81;83;82;82;82;82;82;83;85;86 16:57:34 INFO - PROCESS | 1688 | |11;stanford-crypto-ccm;133;135;132;122;116;122;131;131;137;113 16:57:34 INFO - PROCESS | 1688 | |12;stanford-crypto-pbkdf2;168;169;139;138;135;124;134;134;135;135 16:57:34 INFO - PROCESS | 1688 | |13;stanford-crypto-sha256-iterative;69;65;68;65;78;88;94;74;67;68 16:57:34 INFO - PROCESS | 1688 | __end_tp_report 16:57:34 INFO - PROCESS | 1688 | __start_cc_report 16:57:34 INFO - PROCESS | 1688 | _x_x_mozilla_cycle_collect,912 16:57:34 INFO - PROCESS | 1688 | __end_cc_report 16:57:34 INFO - PROCESS | 1688 | __startTimestamp1464652654638__endTimestamp 16:57:34 INFO - PROCESS | 1688 | 16:57:34 INFO - PROCESS | 1688 | ------- Summary: start ------- 16:57:34 INFO - PROCESS | 1688 | Number of tests: 14 16:57:34 INFO - PROCESS | 1688 | 16:57:34 INFO - PROCESS | 1688 | [#0] ai-astar Cycles:10 Average:125.90 Median:121.50 stddev:15.37 (12.7%) stddev-sans-first:15.30 16:57:34 INFO - PROCESS | 1688 | Values: 141.0 157.0 142.0 116.0 116.0 127.0 115.0 115.0 115.0 115.0 16:57:34 INFO - PROCESS | 1688 | 16:57:34 INFO - PROCESS | 1688 | [#1] audio-beat-detection Cycles:10 Average:138.20 Median:145.00 stddev:10.88 (7.5%) stddev-sans-first:11.17 16:57:34 INFO - PROCESS | 1688 | Values: 146.0 122.0 150.0 145.0 119.0 135.0 136.0 135.0 145.0 149.0 16:57:34 INFO - PROCESS | 1688 | 16:57:34 INFO - PROCESS | 1688 | [#2] audio-dft Cycles:10 Average:197.30 Median:198.00 stddev:2.98 (1.5%) stddev-sans-first:3.05 16:57:34 INFO - PROCESS | 1688 | Values: 195.0 198.0 198.0 201.0 197.0 192.0 201.0 194.0 200.0 197.0 16:57:34 INFO - PROCESS | 1688 | 16:57:34 INFO - PROCESS | 1688 | [#3] audio-fft Cycles:10 Average:86.70 Median:75.00 stddev:34.66 (46.2%) stddev-sans-first:36.41 16:57:34 INFO - PROCESS | 1688 | Values: 73.0 96.0 96.0 149.0 47.0 77.0 49.0 60.0 139.0 81.0 16:57:34 INFO - PROCESS | 1688 | 16:57:34 INFO - PROCESS | 1688 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:81.00 stddev:17.96 (22.2%) stddev-sans-first:18.84 16:57:34 INFO - PROCESS | 1688 | Values: 86.0 81.0 119.0 80.0 82.0 88.0 121.0 81.0 80.0 118.0 16:57:34 INFO - PROCESS | 1688 | 16:57:34 INFO - PROCESS | 1688 | [#5] imaging-gaussian-blur Cycles:10 Average:103.60 Median:74.00 stddev:25.80 (34.9%) stddev-sans-first:26.84 16:57:34 INFO - PROCESS | 1688 | Values: 118.0 129.0 88.0 128.0 76.0 87.0 75.0 73.0 133.0 129.0 16:57:34 INFO - PROCESS | 1688 | 16:57:34 INFO - PROCESS | 1688 | [#6] imaging-darkroom Cycles:10 Average:108.60 Median:96.00 stddev:20.47 (21.3%) stddev-sans-first:21.41 16:57:34 INFO - PROCESS | 1688 | Values: 99.0 139.0 149.0 95.0 94.0 97.0 98.0 95.0 122.0 98.0 16:57:34 INFO - PROCESS | 1688 | 16:57:34 INFO - PROCESS | 1688 | [#7] imaging-desaturate Cycles:10 Average:109.40 Median:90.00 stddev:24.37 (27.1%) stddev-sans-first:25.02 16:57:34 INFO - PROCESS | 1688 | Values: 92.0 95.0 90.0 91.0 87.0 132.0 141.0 145.0 90.0 131.0 16:57:34 INFO - PROCESS | 1688 | 16:57:34 INFO - PROCESS | 1688 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:69.50 stddev:15.20 (21.9%) stddev-sans-first:15.43 16:57:34 INFO - PROCESS | 1688 | Values: 54.0 60.0 58.0 58.0 84.0 87.0 85.0 51.0 50.0 79.0 16:57:34 INFO - PROCESS | 1688 | 16:57:34 INFO - PROCESS | 1688 | [#9] json-stringify-tinderbox Cycles:10 Average:74.00 Median:73.00 stddev:11.80 (16.2%) stddev-sans-first:11.95 16:57:34 INFO - PROCESS | 1688 | Values: 64.0 65.0 72.0 69.0 69.0 74.0 61.0 77.0 95.0 94.0 16:57:34 INFO - PROCESS | 1688 | 16:57:34 INFO - PROCESS | 1688 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:82.50 stddev:1.55 (1.9%) stddev-sans-first:1.50 16:57:34 INFO - PROCESS | 1688 | Values: 81.0 83.0 82.0 82.0 82.0 82.0 82.0 83.0 85.0 86.0 16:57:34 INFO - PROCESS | 1688 | 16:57:34 INFO - PROCESS | 1688 | [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:131.50 stddev:8.32 (6.3%) stddev-sans-first:8.56 16:57:34 INFO - PROCESS | 1688 | Values: 133.0 135.0 132.0 122.0 116.0 122.0 131.0 131.0 137.0 113.0 16:57:34 INFO - PROCESS | 1688 | 16:57:34 INFO - PROCESS | 1688 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.10 Median:136.50 stddev:14.98 (11.0%) stddev-sans-first:12.33 16:57:34 INFO - PROCESS | 1688 | Values: 168.0 169.0 139.0 138.0 135.0 124.0 134.0 134.0 135.0 135.0 16:57:34 INFO - PROCESS | 1688 | 16:57:34 INFO - PROCESS | 1688 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:71.50 stddev:10.10 (14.1%) stddev-sans-first:10.58 16:57:34 INFO - PROCESS | 1688 | Values: 69.0 65.0 68.0 65.0 78.0 88.0 94.0 74.0 67.0 68.0 16:57:34 INFO - PROCESS | 1688 | -------- Summary: end -------- 16:57:34 INFO - PROCESS | 1688 | 16:57:35 INFO - TEST-INFO | 1688: exit 0 16:57:35 INFO - TEST-OK | kraken | took 57781ms 16:57:35 INFO - SUITE-END | took 1169s 16:57:35 INFO - Completed test suite (00:19:29) 16:57:35 INFO - javascript benchmark 16:57:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3673.981630091849, 3698.9445158322646, 3702.3335799556085, 3754.511913451251, 3762.7742335459866, 5958.927393069252, 5990.371011043843, 5997.190379298793, 6021.8193454196335, 6024.849378765533, 5924.703764811753, 5951.434613711701, 6035.2757669079665, 6039.063945088507, 6040.214772079624, 5352.384475785276, 5407.675539467645, 5431.2396264522995, 5486.423925487826, 5509.090999985017, 5358.223057656657, 5471.72641367932, 5482.409022090537, 5482.698451585161, 5503.3120859892515, 5392.325959255093, 5435.83692489224, 5440.102383106782, 5447.972760136214, 5456.563474922016, 5493.697846618435, 5495.917561236584, 5522.392536820947, 5531.695756733378, 5546.4453554644415, 5319.388270348921, 5408.594355423359, 5438.102713052342, 5480.068388373946, 5513.531349835269, 5462.890742185134, 5531.0, 5742.626729262626, 5802.62282951611, 6105.32841387447, 6195.411435913581, 6278.874422511524, 6284.497240220771, 6288.654124023177, 6302.149209856657, 5630.521405680522, 5717.256756621613, 6274.623522588659, 6299.5275354348605, 6310.6213627182515, 6005.909911351377, 6006.3693312201585, 6068.937935861207, 6111.602745821508, 6120.510359171256, 6456.031595260749, 6485.70814313357, 6497.837554061186, 6500.252470965805, 6504.772332968323, 6203.720832562545, 6286.937130628727, 6299.0, 6306.527010474233, 6308.495320374359, 6222.0, 6314.273858506239, 6334.208223972004, 6364.936350636434, 6400.455961243253, 6267.341929097471, 6276.0, 6307.085472606538, 6312.684365781693, 6320.367963203643, 5277.23480095384, 5565.749541270652, 6287.622742635456, 6325.620462772248, 6332.588381755263, 4996.475370086161, 5028.572571331405, 5097.8725531861255, 5116.744162791845, 5150.742462876841, 4132.028973191298, 4408.096340250241, 4610.170169369546, 4632.2819962905805, 4641.907161856811, 6011.098335249748, 6192.164057852132, 6202.224721909762, 6202.875942481125, 6233.0, 6345.270293916259, 6351.047342898602, 6368.29948705642, 6387.201599800025, 6387.329330420332, 6108.847278818065, 6109.266887973472, 6111.786087487006, 6117.174181485442, 6156.445919867144, 5497.945020549823, 5572.804951826666, 5585.860353491195, 5598.580106491948, 5640.984622767941, 6460.289368169498, 6511.967440162769, 6536.052272420472, 6570.5400621956005, 6579.440747536513, 6353.4599559038, 6371.39471750183, 6389.041643753474, 6398.744050237939, 6405.807825765234, 6469.867773139587, 6523.64119973387, 6539.084528165966, 6610.6694665267505, 6636.037774522763, 6225.750969961151, 6281.780137695158, 6309.305976342691, 6335.58818676803, 6350.1744773181035, 6310.905336420049, 6321.020241862519, 6332.873342533031, 6337.493000559852, 6354.93645063562, 6154.922888494585, 6167.814965551041, 6300.117983482408, 6309.652969086745, 6323.620582765049, 5883.2057672213705, 6228.564000520101, 6281.340459251713, 6282.277538083179, 6295.811125666238, 5309.283246761638, 5695.800646977336, 6109.938900611115, 6184.876302474016, 6246.937530624636, 6131.478824299985, 6156.26124865019, 6238.407351301619, 6261.311255761953, 6282.780102696566, 6255.0, 6282.434580887742, 6285.277193122849, 6286.214223222098, 6311.684415779285], "unit": "score", "name": "dojo.html", "value": 5880.10905640586}, {"lowerIsBetter": false, "replicates": [437.55588078100715, 580.9506191973682, 629.98257813631, 635.3709827271001, 670.5473805181502, 34146.48780268298, 40383.79808100963, 40530.7973460133, 40811.0, 40818.59181408185, 42287.154256914844, 42567.57432425675, 42699.359509607384, 42874.92812679685, 43224.13551728964, 9696.563654635524, 9903.50482475877, 9907.752306192368, 9921.702348929508, 9936.105750482455, 9984.600615975389, 10061.39631622105, 10070.69787906364, 10110.898891011106, 10124.987501249852, 8581.52801595912, 10066.647667331645, 10102.646407375743, 10138.49307534624, 10158.28891977562, 9953.552090155961, 9991.250656200778, 10056.0, 10082.092611664912, 10095.596176152945, 8300.916990830076, 9820.0, 9950.253730970206, 9962.302638815287, 9976.201903847676, 40773.184536309105, 40801.79599102015, 41015.97460063492, 41678.58321416807, 42555.36166957498, 3281.1797050737314, 3362.5628668272966, 3404.557407537029, 3420.350133474632, 3438.0889064397707, 28837.56743648847, 29802.254943626365, 29853.70146298531, 29964.250893727614, 30160.69839301601, 2759.075709637274, 2762.875670594828, 2793.8323700577826, 2794.2315863137596, 2821.647294088239, 502958.0, 511294.0, 514087.85912141146, 514576.9999999963, 515929.0, 49780.0, 50600.493995060315, 79629.20370796218, 80375.7943630846, 80896.0, 49561.25658115131, 49741.50258497441, 50488.242676359885, 50553.49446505561, 50746.0, 16666.6666666666, 16713.331466741194, 16724.49826505207, 17033.97796132236, 17171.88382755117, 13627.0, 13656.24890631005, 13661.112027718167, 13794.93102534481, 13819.861801382058, 15990.920045399931, 16064.036157830567, 16165.515034548982, 16678.249478773483, 16684.33262669504, 7192.82017949545, 7235.638218089074, 7235.746748863765, 7298.56208627484, 7312.744053958086, 1002.3785253143097, 1087.4015197659428, 1101.983470247947, 1131.1459847814847, 1138.7893239750672, 27482.862585686944, 28214.43571128566, 29230.0, 32664.183395414828, 33503.497447538306, 1098.7527806243531, 1130.423484023154, 1155.5551112821456, 1166.7899778039864, 1247.6381849263794, 15320.616984575474, 15740.68518629621, 15796.289166987513, 16027.599310017109, 16153.515394538183, 581178.0, 683076.0, 683589.0, 686375.0, 691223.0, 66229.0, 66297.66851165713, 66874.66562667156, 66986.99519507114, 67217.0, 1541.5991842120904, 1543.1821134798574, 1559.173637971854, 1576.692544953746, 1583.1688363608966, 27628.447431051667, 30505.694943050286, 31363.0, 31892.5216121763, 32060.358792824478, 56386.718066409405, 57200.0, 57219.42780572141, 57551.136732949875, 57574.42425575691, 432550.0, 432680.0, 433751.0, 436704.8164759156, 438865.0, 36200.63799362078, 36773.44839827351, 36886.446703298934, 37020.07449813669, 37475.25049499049, 48084.519154808004, 48953.0, 49263.01473970429, 49542.0, 50061.99876002387, 39993.00017499586, 40260.59739402686, 40484.79757601193, 40659.0, 40968.79515602403, 39669.80165099156, 39674.40488392619, 39812.800935996296, 40022.799886000386, 40762.79618602007, 39287.01782455347, 39450.60549394469, 40291.99270018273, 40324.79837600793, 40496.595034049285, 33362.66637333693, 35299.941001769985, 35443.64556354507, 35778.463323049655, 35829.0, 25626.0, 25740.356491087874, 25777.742222578283, 26216.606750899133, 26281.60577591376], "unit": "score", "name": "ext.html", "value": 20536.856295646783}, {"lowerIsBetter": false, "replicates": [328.1533643200542, 361.0810487309796, 361.72508893241144, 373.58345444829024, 375.5943580932593, 17433.0, 20343.796562034375, 20884.582308353823, 22476.775232247674, 22578.0, 20898.05958731857, 21130.366089017316, 21353.893230533864, 21400.14399424021, 21769.891150544227, 5327.307450031491, 5529.447055294479, 5556.111022236423, 5556.305461817273, 5557.638753481031, 5449.237106805051, 5775.249217601727, 6034.637921724689, 6047.637141771485, 6049.153118563405, 5164.4060932992625, 5778.3643799182055, 6024.246969128859, 6036.96981515094, 6079.878402431948, 5859.2675915510345, 5879.67661778602, 5937.287525496947, 5945.732442040118, 5968.67172305523, 4677.438707355105, 6000.33996260411, 6016.75932962681, 6030.577859549833, 6197.977333739973, 13746.96897732664, 13813.963952703587, 13902.443902243898, 13998.30008499571, 14205.0, 2319.4665226997718, 2320.0, 2673.4920365130756, 2806.3264816443907, 2815.591739197805, 9960.003999600054, 9992.550335234931, 10148.289619726622, 10219.978002199794, 10376.584936602527, 1718.269735362466, 1751.2907272554507, 1756.7364895265684, 1772.3885259585422, 1838.2003828334584, 78142.43715125666, 112364.0, 113583.0, 113734.72530549343, 118120.0, 11505.942470287762, 11750.94124529372, 11762.126172998152, 11819.0, 11952.402379881145, 14533.927330363493, 14700.485483008257, 14759.0, 14795.0, 14834.480793172188, 7539.1563562406, 8536.189062039097, 9176.174144327042, 9303.534823258946, 9416.05839416053, 8035.674113771279, 9525.0, 9586.842960333868, 9768.21854251658, 9786.580945762824, 3806.733528652968, 4575.473820510684, 4602.516735742765, 4618.145643056046, 4627.236505976476, 1778.2797966823457, 1925.6052509235574, 1931.3529967461059, 1967.085305333027, 1973.6250112478583, 891.4294851295176, 1030.4744580263969, 1064.5688496159069, 1075.1291453922347, 1089.1504626391427, 17343.437017648117, 20240.089195985922, 20792.58414831725, 21092.261770837948, 21537.67693484599, 937.1425145991478, 973.1728031173446, 976.3848775271675, 1014.6347314966606, 1040.6565833275001, 10258.43578603169, 10942.398168100672, 11166.441677916071, 11193.552257909756, 11196.608118715805, 558581.0, 562927.0, 567291.0, 639523.6047639557, 643071.0, 96122.0, 128451.0, 133934.3303283497, 134316.99999999805, 135497.0, 1055.9894401055892, 1059.1315121600214, 1087.260662749338, 1099.3513826842202, 1110.189561620022, 15041.849581504044, 18815.776974496614, 18954.24183032663, 19136.0, 19293.903530482257, 38986.4152037714, 54396.45603544072, 54694.45305546893, 57397.71301143467, 57871.4212857866, 75882.62058689671, 78611.0, 78892.4221515578, 79056.60471697604, 80305.0, 7987.600619969095, 8177.509349439053, 8191.508509489449, 8271.875921861298, 8282.751517454486, 9461.621535138518, 13069.0, 13372.398242078934, 13395.598132056053, 13420.993425492932, 9569.377990430878, 11091.223614347242, 11297.43512824372, 11469.426528673699, 11631.127665424958, 10992.670219893416, 11374.60188893418, 11595.652130436101, 11815.40922953866, 11843.52625894989, 11630.94184529072, 11677.88322116802, 12079.396030198279, 12130.939345303217, 12165.452554634885, 7950.165232650488, 8086.43394962347, 8208.958955205424, 8249.422540422353, 8427.325813934993, 8451.915480845113, 11275.718107047389, 11627.47676354583, 11764.470598823245, 11873.703157420789], "unit": "score", "name": "jquery.html", "value": 9513.794311127725}, {"lowerIsBetter": false, "replicates": [1676.6898123847088, 1685.7050016247158, 2021.2925476083374, 2078.4803799050246, 2103.9579208415844, 8259.050209225941, 8936.91063089369, 8974.282057435406, 9187.494687792168, 9215.078492150782, 8925.0, 8961.417507861985, 8996.055414181516, 9020.143086406797, 9105.590248438819, 2530.633058206559, 2545.2745967399296, 2550.298667866333, 2559.11710459892, 2562.397836508419, 2483.4039830440656, 2551.4514379408424, 2558.897644094234, 2565.3458368116103, 2567.2169988153605, 2518.6851643544555, 2532.442862570241, 2551.4259291659323, 2555.7316481769426, 2573.626824110512, 2519.4709111086604, 2539.669842920418, 2544.3257536752776, 2547.592385218356, 2574.45936353366, 2155.3533939817994, 2197.3517812245427, 2535.809814263919, 2549.987250063756, 2586.185351614254, 7652.770416887447, 9133.0, 9178.036306187822, 9195.770105747342, 9214.308926830514, 5192.92210616841, 5532.921080389326, 5652.63257888236, 5777.0, 5781.566382521286, 3200.695933886277, 3642.7814331140216, 3720.330340538702, 3740.7942563159286, 3768.9434658480145, 1075.150631001508, 1093.2675107677876, 1093.775775965925, 1098.2586753941057, 1099.6096385783092, 10374.273800833944, 12117.151799374047, 12294.631161065183, 12532.310722910237, 12554.560590379293, 5006.64953453262, 5013.373328333958, 5072.923906141411, 5092.465291144451, 5150.871228219325, 10473.9476302618, 10511.632092876713, 10546.314489558154, 10553.84169237462, 10568.365898046142, 5598.496135347838, 5668.744906479218, 5689.91891540606, 5721.885562288814, 5733.741981610838, 4629.884252893705, 4991.650584459126, 5035.546800787946, 5071.06185355703, 5081.28861959326, 4052.5091654511466, 4091.5499295077516, 4105.322621767435, 4144.7513149211145, 4165.520965088993, 1201.2912381694666, 1359.6736783172166, 1382.5299398204659, 1386.1544457880684, 1391.172252509755, 1229.2317301686446, 1397.9790303145462, 1423.9747381885027, 1482.9925850370894, 1493.57433131557, 8395.496270223806, 8544.444611100258, 8572.27135693473, 8595.828083438297, 8608.655653773903, 535.651169621206, 538.9056915039853, 540.1600511205114, 543.1337017457149, 544.1918750655274, 6325.7785977491485, 6354.936450635527, 6405.167328247391, 6414.198225221848, 6486.318936511692, 10832.133429325793, 11160.609378671708, 11214.439278036065, 11290.604828830952, 11320.943395283135, 10657.520411581498, 10870.912908709066, 10905.945470272598, 11075.224734268684, 11094.0, 7348.191698913115, 8564.95717521421, 8683.392162548687, 8762.299016078827, 8777.956110219537, 7936.0, 8097.352211823158, 8112.391570632344, 8123.79690507742, 8213.425060245725, 9674.661386851427, 9818.950905245429, 9888.406695598287, 9969.0, 10191.796164076824, 10020.498975051363, 10181.440020798631, 10192.898071019195, 10322.793544129225, 10405.271630985759, 7624.0, 7704.30661240491, 7711.730089446843, 7770.14528401864, 7786.0, 8360.707375241838, 8389.66441342364, 8438.029626593021, 8473.406861519634, 8499.362547809063, 7601.7719468416035, 7801.570913599807, 7812.765617031499, 7865.764027079197, 7870.409719271192, 7510.0, 7566.508176968699, 7594.696212151452, 7733.845323093619, 7736.303732664087, 7906.0, 7929.762107136795, 7930.048394192734, 7946.404019698662, 8009.599520024092, 7053.294670532906, 7111.608861512666, 7195.640217989185, 7204.855902882018, 7228.20489746117, 7289.744858929912, 7316.158641756266, 7330.853382932418, 7334.486585938933, 7363.447741419308], "unit": "score", "name": "mootools.html", "value": 5022.643509907213}, {"lowerIsBetter": false, "replicates": [332.65403979860946, 332.758749906318, 333.6996702967329, 334.22459893048136, 340.68316465686917, 6931.306869313066, 6968.815301398762, 6968.96515517423, 6976.093107895979, 6990.196127445345, 6897.413719833808, 6915.827104322394, 6932.549384290018, 6943.444524438046, 6970.198427180876, 4915.697340204831, 5048.545630893219, 5127.307813445174, 5130.4356520782685, 5209.400918894319, 5118.846434606968, 5119.206522988943, 5126.564242039412, 5144.922826157611, 5145.81989630363, 4091.3862920561855, 5075.365579302587, 5089.949100509003, 5095.159298715707, 5144.0740666679985, 5125.154349532341, 5126.436092029874, 5141.897162056756, 5145.897082058356, 5151.562117220041, 4450.26570615848, 4457.465104187519, 4457.8439754608435, 4476.753778542179, 4483.856616562788, 6467.676616169173, 6554.8361290968105, 6713.731450741964, 6783.355581219826, 6820.727170913157, 6010.0, 6032.8190154295, 6059.606125601822, 6060.30306514752, 6070.271567411939, 7383.6677349519405, 7416.258374162595, 7419.8145046374275, 7425.591592462412, 7458.03045604068, 4947.50524947506, 4952.702837829742, 4955.801767929279, 4960.975195124038, 4970.801167953277, 7026.894596581106, 7810.765677029698, 7827.96086019572, 7833.0, 7869.331106855924, 4899.412070551557, 4968.329275547827, 4977.477364876709, 4993.650444468925, 5014.423341315795, 4393.450818647669, 4833.864041950139, 5083.440821509631, 5087.465816089258, 5103.668261562986, 5934.910976335358, 5955.731992060368, 5956.225690660273, 5959.046552551571, 6019.157317975487, 7419.6661150248365, 7431.516951398142, 7437.1447283562, 7479.962600187073, 7491.213422590658, 1703.7103692372327, 1751.6146447781468, 1751.7985431675265, 1771.6545273671768, 1799.145405932198, 1142.2404101272562, 1143.6226045404997, 1156.6587856582328, 1158.8435561199299, 1162.4536467860091, 6932.584044957319, 6989.860202796017, 6993.580385176906, 6997.335253150943, 7027.648617569101, 7659.4255430841795, 7682.1549629540705, 7692.423068269902, 7693.961530192313, 7718.035245594301, 6964.756233531802, 6969.477289203229, 6997.1253593300835, 7011.719531218796, 7024.297570243037, 3326.2515933914674, 3734.215814678948, 4050.4531888195306, 4062.659322423593, 4081.9795901020307, 7894.881576776353, 8036.557989310527, 8130.19508269646, 8139.22677345663, 8145.755627331189, 8004.599770011476, 8012.879806802903, 8022.0, 8027.996500437445, 8041.954545908994, 8085.676572937016, 8134.877976830352, 8139.348852091937, 8147.0, 8154.959225203836, 7472.887906681295, 7730.806729831799, 7791.4935529190425, 7796.10344810354, 7837.451378403685, 6520.445762110274, 7615.6953721850505, 7640.656170472231, 7650.426218033558, 7660.233976602518, 8113.391495637733, 8128.187181281824, 8143.778433234826, 8154.429189956646, 8159.836803263783, 5064.265681476239, 5080.618953578571, 5092.770825312796, 5107.463716309734, 5109.948900510947, 5883.441073098049, 6291.276503202191, 7724.266194711493, 7733.4973226740085, 7760.495567788075, 7433.553986760811, 7454.403647708062, 7478.70085196586, 7522.097348318237, 7531.058617672791, 7454.440916931143, 7462.216467270859, 7482.0, 7486.5508069516, 7490.438217133627, 6990.951357296446, 7284.453665975179, 7299.124105107421, 7299.781006569811, 7330.926690733238, 7397.593132377771, 7452.0, 7466.290702383265, 7470.140933792466, 7477.289657482531, 6062.696865156637, 6233.283172435228, 7209.95455658937, 7285.7814265572115, 7327.37717294036], "unit": "score", "name": "prototype.html", "value": 5444.897198138181}, {"lowerIsBetter": false, "replicates": [651.8240075179699, 670.2827974067746, 692.6277499563994, 714.8105751975727, 755.4862693368509, 13364.933175334121, 13979.30103494825, 14944.252787360629, 15009.849901500982, 15091.39634414622, 14196.71606567868, 14246.358913848875, 14251.572452826405, 14275.0, 14297.71404571908, 802.9277365037145, 941.1999800169853, 953.7043516509904, 970.0687340153461, 977.6578197630807, 939.0750111140521, 971.0241207586402, 971.1647982734843, 971.480258061937, 973.9561719722594, 988.6737376665683, 994.1301361308855, 1002.2132625888679, 1015.7917626886507, 1023.738946568624, 985.0887928665991, 991.0733464210914, 1011.5245834457793, 1015.7308313296983, 1016.547636301846, 611.9173911521932, 737.8745613245761, 747.8354761952362, 748.4498893313411, 754.3964828137523, 14976.17631030293, 14977.925110374488, 15152.696946061127, 15248.161351125684, 15452.381904723798, 12975.935120324433, 12983.156094853899, 13092.738145237137, 13096.934515327457, 13170.60488185356, 10123.371153941422, 10235.488225588691, 10275.743106422324, 10325.070743633034, 10362.378257304586, 3551.5560554930635, 3607.981960090183, 3682.558093028827, 3682.7181448839165, 3698.4822124902535, 82911.585442073, 83067.5846620769, 83208.75186872263, 84293.0, 86164.27671446536, 9597.23222142227, 9650.662226822027, 9667.226621870373, 9709.465979371062, 9971.800563988825, 21405.464863378227, 21683.241086561895, 21723.131074757148, 22506.099756009902, 22547.774522254567, 7537.773866784005, 7648.541087534766, 7762.146163921964, 7842.333401660922, 7882.211778822187, 4189.97905010473, 4190.958090419118, 4234.894127646833, 4244.808983595745, 4342.435483387139, 3671.4492826076303, 3703.2223233121344, 3707.277080969185, 3712.276106159273, 3715.7398982070995, 670.4100391655312, 678.281022116558, 679.4869873245767, 690.226945820684, 695.8886578147473, 571.4085921071754, 585.4204337705726, 596.6956852005421, 601.6089541797779, 622.9221347331584, 7642.465027448136, 8037.397195210383, 8247.432987732313, 8379.329653627696, 8447.915520844836, 523.8057229516708, 551.7241379310345, 558.4108765252616, 592.0, 642.2164958750317, 3316.817575033396, 3892.416137579329, 3912.8434862605177, 3953.5058117735284, 3955.564887862333, 55495.72252138794, 89881.10118898858, 99847.50228746574, 103864.0, 104231.95768042223, 64813.351866480734, 64955.02567461492, 65395.0, 65420.34579654143, 76587.0, 65989.34010659928, 67529.66235168891, 67824.66087669629, 69014.0, 69633.0, 8369.623366948625, 8611.913880861111, 8645.049044604963, 8655.913440865763, 8721.520316382659, 48126.0, 49909.500904990484, 50097.747556311384, 50587.49412505975, 51457.0, 67717.0, 68743.65628171827, 69001.0, 69638.65180674064, 70358.0, 10221.488925553544, 10802.405867677353, 10897.67306980792, 10926.175838456476, 11459.31244125355, 11838.112141589243, 12066.457009434422, 12144.392780361124, 12154.696132596755, 12576.30830304342, 11467.770644587228, 11544.653660390202, 11626.069914406658, 11724.120690948042, 11864.99147572466, 11671.708207294885, 11675.941620292184, 11752.35362055061, 12013.219140756173, 12133.0, 11331.830022549833, 11362.0, 11482.138839586898, 11789.469473873525, 11806.232594881305, 9637.951810240904, 9798.069183427562, 9876.308658393844, 9897.208223342259, 10242.948785256027, 9880.0, 9885.752856178653, 9942.950285248528, 9945.701628951143, 9992.750181245236], "unit": "score", "name": "yui.html", "value": 7012.109876896449}], "name": "dromaeo_css", "value": 7771.64394822392}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [141.0, 157.0, 142.0, 116.0, 116.0, 127.0, 115.0, 115.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 125.9}, {"lowerIsBetter": true, "replicates": [146.0, 122.0, 150.0, 145.0, 119.0, 135.0, 136.0, 135.0, 145.0, 149.0], "unit": "score", "name": "audio-beat-detection", "value": 138.2}, {"lowerIsBetter": true, "replicates": [195.0, 198.0, 198.0, 201.0, 197.0, 192.0, 201.0, 194.0, 200.0, 197.0], "unit": "score", "name": "audio-dft", "value": 197.3}, {"lowerIsBetter": true, "replicates": [73.0, 96.0, 96.0, 149.0, 47.0, 77.0, 49.0, 60.0, 139.0, 81.0], "unit": "score", "name": "audio-fft", "value": 86.7}, {"lowerIsBetter": true, "replicates": [86.0, 81.0, 119.0, 80.0, 82.0, 88.0, 121.0, 81.0, 80.0, 118.0], "unit": "score", "name": "audio-oscillator", "value": 93.6}, {"lowerIsBetter": true, "replicates": [118.0, 129.0, 88.0, 128.0, 76.0, 87.0, 75.0, 73.0, 133.0, 129.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 103.6}, {"lowerIsBetter": true, "replicates": [99.0, 139.0, 149.0, 95.0, 94.0, 97.0, 98.0, 95.0, 122.0, 98.0], "unit": "score", "name": "imaging-darkroom", "value": 108.6}, {"lowerIsBetter": true, "replicates": [92.0, 95.0, 90.0, 91.0, 87.0, 132.0, 141.0, 145.0, 90.0, 131.0], "unit": "score", "name": "imaging-desaturate", "value": 109.4}, {"lowerIsBetter": true, "replicates": [54.0, 60.0, 58.0, 58.0, 84.0, 87.0, 85.0, 51.0, 50.0, 79.0], "unit": "score", "name": "json-parse-financial", "value": 66.6}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 72.0, 69.0, 69.0, 74.0, 61.0, 77.0, 95.0, 94.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 74.0}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 82.0, 82.0, 82.0, 82.0, 82.0, 83.0, 85.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [133.0, 135.0, 132.0, 122.0, 116.0, 122.0, 131.0, 131.0, 137.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.2}, {"lowerIsBetter": true, "replicates": [168.0, 169.0, 139.0, 138.0, 135.0, 124.0, 134.0, 134.0, 135.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.1}, {"lowerIsBetter": true, "replicates": [69.0, 65.0, 68.0, 65.0, 78.0, 88.0, 94.0, 74.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 73.6}], "name": "kraken", "value": 1528.6}]} 16:57:35 INFO - Return code: 0 16:57:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:57:35 ERROR - # TBPL SUCCESS # 16:57:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:57:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:57:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:57:35 INFO - 2016-05-30 16:57:35.971 screenresolution[1693:11295] starting screenresolution argv=screenresolution get 16:57:35 INFO - 2016-05-30 16:57:35.974 screenresolution[1693:11295] Display 0: 1600x1200x32@60 16:57:35 INFO - 2016-05-30 16:57:35.980 screenresolution[1694:11298] starting screenresolution argv=screenresolution list 16:57:35 INFO - Available Modes on Display 0 16:57:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:57:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:57:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:57:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:57:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:57:36 INFO - Intel Iris: 16:57:36 INFO - Chipset Model: Intel Iris 16:57:36 INFO - Type: GPU 16:57:36 INFO - Bus: Built-In 16:57:36 INFO - VRAM (Dynamic, Max): 1536 MB 16:57:36 INFO - Vendor: Intel (0x8086) 16:57:36 INFO - Device ID: 0x0a2e 16:57:36 INFO - Revision ID: 0x0009 16:57:36 INFO - Displays: 16:57:36 INFO - Display: 16:57:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:57:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:57:36 INFO - Display Serial Number: 1600x1200 60 16:57:36 INFO - Main Display: Yes 16:57:36 INFO - Mirror: Off 16:57:36 INFO - Online: Yes 16:57:36 INFO - Rotation: Supported 16:57:36 INFO - Return code: 0 16:57:36 INFO - Running post-action listener: _resource_record_post_action 16:57:36 INFO - Running post-run listener: _resource_record_post_run 16:57:37 INFO - Total resource usage - Wall time: 1194s; CPU: 53.0%; Read bytes: 32554496; Write bytes: 511861248; Read time: 326; Write time: 1673 16:57:37 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 202873344; Write bytes: 198744064; Read time: 18695; Write time: 452 16:57:37 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 30772736; Write bytes: 302320128; Read time: 304; Write time: 1190 16:57:37 INFO - Running post-run listener: _upload_blobber_files 16:57:37 INFO - Blob upload gear active. 16:57:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:57:37 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:57:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:57:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:57:37 INFO - (blobuploader) - INFO - Open directory for files ... 16:57:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:57:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:57:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:57:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:57:38 INFO - (blobuploader) - INFO - Done attempting. 16:57:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:57:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:57:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:57:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:57:39 INFO - (blobuploader) - INFO - Done attempting. 16:57:39 INFO - (blobuploader) - INFO - Iteration through files over. 16:57:39 INFO - Return code: 0 16:57:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:57:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:57:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a174ed7712b5fc6472410980f5ab297103a1d79f60c97d4d85e3790f4a36e18c2c4dad55441c6835d883791e35db77b5947e962ff3f219bed1a63d5bcb0e0c22", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ba053162ee34c548e541e04a631b74bfdfdcf904724db68c08574d17e95bd952169fb6b0c6e8d16d6c546695961a027eccd93e1f1adbe2b3c60a5c5ff54f54e3"} 16:57:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:57:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:57:39 INFO - Contents: 16:57:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a174ed7712b5fc6472410980f5ab297103a1d79f60c97d4d85e3790f4a36e18c2c4dad55441c6835d883791e35db77b5947e962ff3f219bed1a63d5bcb0e0c22", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ba053162ee34c548e541e04a631b74bfdfdcf904724db68c08574d17e95bd952169fb6b0c6e8d16d6c546695961a027eccd93e1f1adbe2b3c60a5c5ff54f54e3"} 16:57:39 INFO - Running post-run listener: copy_logs_to_upload_dir 16:57:39 INFO - Copying logs to upload dir... 16:57:39 INFO - mkdir: /builds/slave/test/build/upload/logs 16:57:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1300.051278 ========= master_lag: 2.67 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 42 secs) (at 2016-05-30 16:57:42.578703) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 16:57:42.586891) ========= 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.nUK1c5mLTD/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.gY0igXShkN/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a174ed7712b5fc6472410980f5ab297103a1d79f60c97d4d85e3790f4a36e18c2c4dad55441c6835d883791e35db77b5947e962ff3f219bed1a63d5bcb0e0c22", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ba053162ee34c548e541e04a631b74bfdfdcf904724db68c08574d17e95bd952169fb6b0c6e8d16d6c546695961a027eccd93e1f1adbe2b3c60a5c5ff54f54e3"} build_url:https://queue.taskcluster.net/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011321 build_url: 'https://queue.taskcluster.net/v1/task/e8rZz6AOSjuCacoZyaE_Lw/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a174ed7712b5fc6472410980f5ab297103a1d79f60c97d4d85e3790f4a36e18c2c4dad55441c6835d883791e35db77b5947e962ff3f219bed1a63d5bcb0e0c22", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ba053162ee34c548e541e04a631b74bfdfdcf904724db68c08574d17e95bd952169fb6b0c6e8d16d6c546695961a027eccd93e1f1adbe2b3c60a5c5ff54f54e3"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 16:57:42.630115) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:57:42.630420) ========= 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.nUK1c5mLTD/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.gY0igXShkN/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.005257 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 16:57:42.678048) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 16:57:42.678343) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 16:57:42.680905) ========= ========= Total master_lag: 2.81 =========