builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0052 starttime: 1469548154.38 results: success (0) buildid: 20160726073802 builduid: 6c72781d2b374e1f98a541c9c018fb4c revision: 958cee08361af9ed370be06695973bcda3d3aa46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 08:49:14.384801) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 08:49:14.385318) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 08:49:14.385642) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 08:49:14.410901) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 08:49:14.411316) ========= 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.CTFaoSkxjX/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.UdLVHZadaP/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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-07-26 08:49:14-- 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% 65.8M=0s 2016-07-26 08:49:14 (65.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085138 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 08:49:14.519082) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 08:49:14.519438) ========= 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.CTFaoSkxjX/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.UdLVHZadaP/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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.030089 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 08:49:14.571405) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-26 08:49:14.571800) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 958cee08361af9ed370be06695973bcda3d3aa46 --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 958cee08361af9ed370be06695973bcda3d3aa46 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CTFaoSkxjX/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.UdLVHZadaP/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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-07-26 08:49:14,651 truncating revision to first 12 chars 2016-07-26 08:49:14,651 Setting DEBUG logging. 2016-07-26 08:49:14,651 attempt 1/10 2016-07-26 08:49:14,651 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/958cee08361a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-26 08:49:15,670 unpacking tar archive at: mozilla-beta-958cee08361a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.278346 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-26 08:49:15.872612) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 08:49:15.872996) ========= script_repo_revision: 958cee08361af9ed370be06695973bcda3d3aa46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 08:49:15.873508) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 08:49:15.873822) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 08:49:15.892637) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-07-26 08:49:15.893086) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.CTFaoSkxjX/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.UdLVHZadaP/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 08:49:16 INFO - MultiFileLogger online at 20160726 08:49:16 in /builds/slave/test 08:49:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:49:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:49:16 INFO - {'append_to_log': False, 08:49:16 INFO - 'base_work_dir': '/builds/slave/test', 08:49:16 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:49:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:49:16 INFO - 'branch': 'Mozilla-Beta', 08:49:16 INFO - 'buildbot_json_path': 'buildprops.json', 08:49:16 INFO - 'config_files': ('talos/mac_config.py',), 08:49:16 INFO - 'default_actions': ('clobber', 08:49:16 INFO - 'read-buildbot-config', 08:49:16 INFO - 'download-and-extract', 08:49:16 INFO - 'populate-webroot', 08:49:16 INFO - 'create-virtualenv', 08:49:16 INFO - 'install', 08:49:16 INFO - 'run-tests'), 08:49:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:49:16 INFO - 'download_minidump_stackwalk': True, 08:49:16 INFO - 'download_symbols': 'ondemand', 08:49:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:49:16 INFO - 'tooltool.py': '/tools/tooltool.py', 08:49:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:49:16 INFO - '/tools/misc-python/virtualenv.py')}, 08:49:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:49:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:49:16 INFO - 'installer_path': 'installer.exe', 08:49:16 INFO - 'log_level': 'info', 08:49:16 INFO - 'log_name': 'talos', 08:49:16 INFO - 'log_to_console': True, 08:49:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:49:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:49:16 INFO - 'opt_config_files': (), 08:49:16 INFO - 'pip_index': False, 08:49:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:49:16 INFO - 'cmd': ('bash', 08:49:16 INFO - '-c', 08:49:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:49:16 INFO - 'enabled': True, 08:49:16 INFO - 'halt_on_failure': False, 08:49:16 INFO - 'name': 'check_screen_resolution'},), 08:49:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:49:16 INFO - 'cmd': ('bash', 08:49:16 INFO - '-c', 08:49:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:49:16 INFO - 'enabled': True, 08:49:16 INFO - 'halt_on_failure': False, 08:49:16 INFO - 'name': 'check_screen_resolution'},), 08:49:16 INFO - 'run_cmd_checks_enabled': True, 08:49:16 INFO - 'sps_profile': False, 08:49:16 INFO - 'sps_profile_interval': 0, 08:49:16 INFO - 'suite': 'dromaeojs', 08:49:16 INFO - 'system_bits': '32', 08:49:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:49:16 INFO - 'title': 't-yosemite-r7-0052', 08:49:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:49:16 INFO - 'use_talos_json': True, 08:49:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:49:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:49:16 INFO - 'work_dir': 'build'} 08:49:16 INFO - ##### 08:49:16 INFO - ##### Running clobber step. 08:49:16 INFO - ##### 08:49:16 INFO - Running pre-action listener: _resource_record_pre_action 08:49:16 INFO - Running main action method: clobber 08:49:16 INFO - rmtree: /builds/slave/test/build 08:49:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:49:18 INFO - Running post-action listener: _resource_record_post_action 08:49:18 INFO - ##### 08:49:18 INFO - ##### Running read-buildbot-config step. 08:49:18 INFO - ##### 08:49:18 INFO - Running pre-action listener: _resource_record_pre_action 08:49:18 INFO - Running main action method: read_buildbot_config 08:49:18 INFO - Using buildbot properties: 08:49:18 INFO - { 08:49:18 INFO - "project": "", 08:49:18 INFO - "product": "firefox", 08:49:18 INFO - "script_repo_revision": "production", 08:49:18 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 08:49:18 INFO - "repository": "", 08:49:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 08:49:18 INFO - "buildid": "20160726073802", 08:49:18 INFO - "pgo_build": "False", 08:49:18 INFO - "basedir": "/builds/slave/test", 08:49:18 INFO - "buildnumber": 22, 08:49:18 INFO - "slavename": "t-yosemite-r7-0052", 08:49:18 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 08:49:18 INFO - "platform": "yosemite_r7", 08:49:18 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:49:18 INFO - "branch": "mozilla-beta", 08:49:18 INFO - "repo_path": "releases/mozilla-beta", 08:49:18 INFO - "revision": "958cee08361af9ed370be06695973bcda3d3aa46", 08:49:18 INFO - "stage_platform": "macosx64", 08:49:18 INFO - "builduid": "6c72781d2b374e1f98a541c9c018fb4c", 08:49:18 INFO - "slavebuilddir": "test" 08:49:18 INFO - } 08:49:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 08:49:18 INFO - Running post-action listener: _resource_record_post_action 08:49:18 INFO - ##### 08:49:18 INFO - ##### Running download-and-extract step. 08:49:18 INFO - ##### 08:49:18 INFO - Running pre-action listener: _resource_record_pre_action 08:49:18 INFO - Running main action method: download_and_extract 08:49:18 INFO - mkdir: /builds/slave/test/build/tests 08:49: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')]} 08:49:18 INFO - https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:49:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 08:49:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 08:49:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 08:49:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 08:49:31 INFO - Downloaded 1165 bytes. 08:49:31 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 08:49:31 INFO - Using the following test package requirements: 08:49:31 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 08:49:31 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:49:31 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 08:49:31 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:49:31 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 08:49:31 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:49:31 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:49:31 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 08:49:31 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 08:49:31 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:49:31 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 08:49:31 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:49:31 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 08:49:31 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:49:31 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 08:49:31 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:49:31 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 08:49:31 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 08:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:31 INFO - https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:49:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:49:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:49:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 08:49:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 08:49:33 INFO - Downloaded 18314870 bytes. 08:49:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:49:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:49:36 INFO - Return code: 0 08:49:36 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 08:49: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')]} 08:49:36 INFO - https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:49:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:49:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:49:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 08:49:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 08:49:41 INFO - Downloaded 18314870 bytes. 08:49:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:49:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:49:44 INFO - Return code: 0 08:49:44 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')]} 08:49:44 INFO - https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:49:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 08:49:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 08:49:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 08:49:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 08:49:45 INFO - Downloaded 10840145 bytes. 08:49:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:49:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 08:49:45 INFO - Return code: 0 08:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:45 INFO - https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 08:49:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:49:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:49:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 08:49:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 08:49:52 INFO - Downloaded 86255188 bytes. 08:49:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:49:52 INFO - mkdir: /builds/slave/test/properties 08:49:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:49:52 INFO - Writing to file /builds/slave/test/properties/build_url 08:49:52 INFO - Contents: 08:49:52 INFO - build_url:https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:49:53 INFO - Running post-action listener: _resource_record_post_action 08:49:53 INFO - Running post-action listener: set_extra_try_arguments 08:49:53 INFO - ##### 08:49:53 INFO - ##### Running populate-webroot step. 08:49:53 INFO - ##### 08:49:53 INFO - Running pre-action listener: _resource_record_pre_action 08:49:53 INFO - Running main action method: populate_webroot 08:49:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:49:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:49:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:49:53 INFO - '--tppagecycles', 08:49:53 INFO - '7'], 08:49:53 INFO - 'tests': ['tsvgm']}}, 08:49:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:49:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:49:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:49:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:49:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:49:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:49:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:53 INFO - 'talos_options': ['--disable-e10s'], 08:49:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:49:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:49:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:53 INFO - 'talos_options': ['--disable-e10s'], 08:49:53 INFO - 'tests': ['damp', 'tps']}, 08:49:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:53 INFO - 'tests': ['damp', 'tps']}, 08:49:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:49:53 INFO - 'tests': ['dromaeo_dom']}, 08:49:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:49:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:49:53 INFO - 'tests': ['a11yr', 08:49:53 INFO - 'ts_paint', 08:49:53 INFO - 'tpaint', 08:49:53 INFO - 'sessionrestore', 08:49:53 INFO - 'sessionrestore_no_auto_restore', 08:49:53 INFO - 'tabpaint']}, 08:49:53 INFO - 'other-e10s': {'tests': ['a11yr', 08:49:53 INFO - 'ts_paint', 08:49:53 INFO - 'tpaint', 08:49:53 INFO - 'sessionrestore', 08:49:53 INFO - 'sessionrestore_no_auto_restore', 08:49:53 INFO - 'tabpaint']}, 08:49:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:49:53 INFO - 'ts_paint', 08:49:53 INFO - 'tpaint', 08:49:53 INFO - 'sessionrestore', 08:49:53 INFO - 'sessionrestore_no_auto_restore', 08:49:53 INFO - 'tabpaint']}, 08:49:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:49:53 INFO - 'ts_paint', 08:49:53 INFO - 'tpaint', 08:49:53 INFO - 'sessionrestore', 08:49:53 INFO - 'sessionrestore_no_auto_restore', 08:49:53 INFO - 'tabpaint']}, 08:49:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:49:53 INFO - 'tests': ['a11yr', 08:49:53 INFO - 'ts_paint', 08:49:53 INFO - 'tpaint', 08:49:53 INFO - 'sessionrestore', 08:49:53 INFO - 'sessionrestore_no_auto_restore', 08:49:53 INFO - 'tabpaint']}, 08:49:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:49:53 INFO - 'tests': ['a11yr', 08:49:53 INFO - 'ts_paint', 08:49:53 INFO - 'tpaint', 08:49:53 INFO - 'sessionrestore', 08:49:53 INFO - 'sessionrestore_no_auto_restore', 08:49:53 INFO - 'tabpaint']}, 08:49:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:49:53 INFO - 'tests': ['tsvgx', 08:49:53 INFO - 'tsvgr_opacity', 08:49:53 INFO - 'tart', 08:49:53 INFO - 'tscrollx', 08:49:53 INFO - 'cart']}, 08:49:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:49:53 INFO - 'tsvgr_opacity', 08:49:53 INFO - 'tart', 08:49:53 INFO - 'tscrollx', 08:49:53 INFO - 'cart']}, 08:49:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:53 INFO - 'talos_options': ['--disable-e10s'], 08:49:53 INFO - 'tests': ['tp5o']}, 08:49:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:53 INFO - 'tests': ['tp5o']}, 08:49:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:53 INFO - 'talos_options': ['--disable-e10s', 08:49:53 INFO - '--xperf_path', 08:49:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:49:53 INFO - 'tests': ['tp5n']}, 08:49:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:53 INFO - 'talos_options': ['--xperf_path', 08:49:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:49:53 INFO - 'tests': ['tp5n']}}, 08:49:53 INFO - 'talos.zip': {'path': '', 08:49:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:49:53 INFO - Running post-action listener: _resource_record_post_action 08:49:53 INFO - ##### 08:49:53 INFO - ##### Running create-virtualenv step. 08:49:53 INFO - ##### 08:49:53 INFO - Running pre-action listener: _resource_record_pre_action 08:49:53 INFO - Running main action method: create_virtualenv 08:49:53 INFO - Creating virtualenv /builds/slave/test/build/venv 08:49:53 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 08:49:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:49:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:49:54 INFO - Using real prefix '/tools/python27' 08:49:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:49:54 INFO - Installing distribute.............................................................................................................................................................................................done. 08:49:57 INFO - Installing pip.................done. 08:49:57 INFO - Return code: 0 08:49:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1043b1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043c1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5a0d58bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104250e00>, '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 0x1040b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10424bb20>, '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.CTFaoSkxjX/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.UdLVHZadaP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 08:49:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:49:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:49:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CTFaoSkxjX/Render', 08:49:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:57 INFO - 'HOME': '/Users/cltbld', 08:49:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:57 INFO - 'LOGNAME': 'cltbld', 08:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:57 INFO - 'MOZ_NO_REMOTE': '1', 08:49:57 INFO - 'NO_EM_RESTART': '1', 08:49:57 INFO - 'PAGER': '/bin/cat', 08:49:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:57 INFO - 'PWD': '/builds/slave/test', 08:49:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:57 INFO - 'SHELL': '/bin/bash', 08:49:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UdLVHZadaP/Listeners', 08:49:57 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 08:49:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:57 INFO - 'USER': 'cltbld', 08:49:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:57 INFO - 'XPC_FLAGS': '0x0', 08:49:57 INFO - 'XPC_SERVICE_NAME': '0', 08:49:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:58 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 08:49:58 INFO - Cleaning up... 08:49:58 INFO - Return code: 0 08:49:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:49:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:58 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 0x1043b1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043c1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5a0d58bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104250e00>, '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 0x1040b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10424bb20>, '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.CTFaoSkxjX/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.UdLVHZadaP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 08:49:58 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 08:49:58 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 08:49:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CTFaoSkxjX/Render', 08:49:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:58 INFO - 'HOME': '/Users/cltbld', 08:49:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:58 INFO - 'LOGNAME': 'cltbld', 08:49:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:58 INFO - 'MOZ_NO_REMOTE': '1', 08:49:58 INFO - 'NO_EM_RESTART': '1', 08:49:58 INFO - 'PAGER': '/bin/cat', 08:49:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:58 INFO - 'PWD': '/builds/slave/test', 08:49:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:58 INFO - 'SHELL': '/bin/bash', 08:49:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UdLVHZadaP/Listeners', 08:49:58 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 08:49:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:58 INFO - 'USER': 'cltbld', 08:49:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:58 INFO - 'XPC_FLAGS': '0x0', 08:49:58 INFO - 'XPC_SERVICE_NAME': '0', 08:49:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:58 INFO - Downloading/unpacking psutil>=0.7.1 08:49:58 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 08:49:58 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 08:49:58 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 08:49:58 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 08:49:58 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 08:49:58 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 08:50:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:50:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:50:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:50:01 INFO - Installing collected packages: psutil 08:50:01 INFO - Running setup.py install for psutil 08:50:01 INFO - building 'psutil._psutil_osx' extension 08:50:01 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 08:50:01 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 08:50:02 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 08:50:02 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 08:50:02 INFO - building 'psutil._psutil_posix' extension 08:50:02 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 08:50:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:50:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:50:02 INFO - ^ 08:50:02 INFO - 1 warning generated. 08:50:02 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 08:50:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:50:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:50:02 INFO - Successfully installed psutil 08:50:02 INFO - Cleaning up... 08:50:02 INFO - Return code: 0 08:50:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:50:02 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')]} 08:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:02 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')]} 08:50:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:02 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 0x1043b1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043c1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5a0d58bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104250e00>, '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 0x1040b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10424bb20>, '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.CTFaoSkxjX/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.UdLVHZadaP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 08:50:02 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 08:50:02 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 08:50:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CTFaoSkxjX/Render', 08:50:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:02 INFO - 'HOME': '/Users/cltbld', 08:50:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:02 INFO - 'LOGNAME': 'cltbld', 08:50:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:02 INFO - 'MOZ_NO_REMOTE': '1', 08:50:02 INFO - 'NO_EM_RESTART': '1', 08:50:02 INFO - 'PAGER': '/bin/cat', 08:50:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:02 INFO - 'PWD': '/builds/slave/test', 08:50:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:02 INFO - 'SHELL': '/bin/bash', 08:50:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UdLVHZadaP/Listeners', 08:50:02 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 08:50:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:02 INFO - 'USER': 'cltbld', 08:50:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:02 INFO - 'XPC_FLAGS': '0x0', 08:50:02 INFO - 'XPC_SERVICE_NAME': '0', 08:50:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:50:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:50:05 INFO - Installing collected packages: mozsystemmonitor 08:50:05 INFO - Running setup.py install for mozsystemmonitor 08:50:05 INFO - Successfully installed mozsystemmonitor 08:50:05 INFO - Cleaning up... 08:50:05 INFO - Return code: 0 08:50:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:50:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:05 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 0x1043b1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043c1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5a0d58bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104250e00>, '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 0x1040b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10424bb20>, '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.CTFaoSkxjX/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.UdLVHZadaP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 08:50:05 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 08:50:05 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 08:50:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CTFaoSkxjX/Render', 08:50:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:05 INFO - 'HOME': '/Users/cltbld', 08:50:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:05 INFO - 'LOGNAME': 'cltbld', 08:50:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:05 INFO - 'MOZ_NO_REMOTE': '1', 08:50:05 INFO - 'NO_EM_RESTART': '1', 08:50:05 INFO - 'PAGER': '/bin/cat', 08:50:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:05 INFO - 'PWD': '/builds/slave/test', 08:50:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:05 INFO - 'SHELL': '/bin/bash', 08:50:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UdLVHZadaP/Listeners', 08:50:05 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 08:50:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:05 INFO - 'USER': 'cltbld', 08:50:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:05 INFO - 'XPC_FLAGS': '0x0', 08:50:05 INFO - 'XPC_SERVICE_NAME': '0', 08:50:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:05 INFO - Downloading/unpacking blobuploader==1.2.4 08:50:05 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 08:50:05 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 08:50:05 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 08:50:05 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 08:50:05 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 08:50:05 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 08:50:08 INFO - Downloading blobuploader-1.2.4.tar.gz 08:50:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:50:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:50:08 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 08:50:08 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 08:50:08 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 08:50:08 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 08:50:08 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 08:50:08 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 08:50:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:50:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:50:08 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 08:50:08 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 08:50:08 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 08:50:08 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 08:50:08 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 08:50:08 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 08:50:09 INFO - Downloading docopt-0.6.1.tar.gz 08:50:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:50:09 INFO - Installing collected packages: blobuploader, requests, docopt 08:50:09 INFO - Running setup.py install for blobuploader 08:50:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:50:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:50:09 INFO - Running setup.py install for requests 08:50:10 INFO - Running setup.py install for docopt 08:50:10 INFO - Successfully installed blobuploader requests docopt 08:50:10 INFO - Cleaning up... 08:50:10 INFO - Return code: 0 08:50:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50: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')]} 08:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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')]} 08:50:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:10 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 0x1043b1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043c1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5a0d58bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104250e00>, '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 0x1040b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10424bb20>, '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.CTFaoSkxjX/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.UdLVHZadaP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 08:50:10 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 08:50:10 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 08:50:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CTFaoSkxjX/Render', 08:50:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:10 INFO - 'HOME': '/Users/cltbld', 08:50:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:10 INFO - 'LOGNAME': 'cltbld', 08:50:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:10 INFO - 'MOZ_NO_REMOTE': '1', 08:50:10 INFO - 'NO_EM_RESTART': '1', 08:50:10 INFO - 'PAGER': '/bin/cat', 08:50:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:10 INFO - 'PWD': '/builds/slave/test', 08:50:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:10 INFO - 'SHELL': '/bin/bash', 08:50:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UdLVHZadaP/Listeners', 08:50:10 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 08:50:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:10 INFO - 'USER': 'cltbld', 08:50:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:10 INFO - 'XPC_FLAGS': '0x0', 08:50:10 INFO - 'XPC_SERVICE_NAME': '0', 08:50:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:50:10 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-Neki6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:50:10 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-sI8Oha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:50:10 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-zpHmm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:50:10 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-OL03xm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:50:11 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-IrfQ6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:50:11 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-67UzjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:50:11 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-tWldnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:50:11 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-E9MFnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:50:11 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-1mJ39H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:50:11 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-0GAVGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:50:11 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-PbgNtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:50:11 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-LAB_TU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:50:11 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-_JB4Qq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:50:11 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-MSjvH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:12 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-KwgMPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:50:12 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-JaBh5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:50:12 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-AeQDRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:50:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:50:12 INFO - Running setup.py install for manifestparser 08:50:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:50:12 INFO - Running setup.py install for mozcrash 08:50:12 INFO - Running setup.py install for mozdebug 08:50:12 INFO - Running setup.py install for mozdevice 08:50:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:50:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:50:12 INFO - Running setup.py install for mozfile 08:50:13 INFO - Running setup.py install for mozhttpd 08:50:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:50:13 INFO - Running setup.py install for mozinfo 08:50:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:50:13 INFO - Running setup.py install for mozInstall 08:50:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:50:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:50:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:50:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:50:13 INFO - Running setup.py install for mozleak 08:50:13 INFO - Running setup.py install for mozlog 08:50:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:50:13 INFO - Running setup.py install for moznetwork 08:50:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:50:14 INFO - Running setup.py install for mozprocess 08:50:14 INFO - Running setup.py install for mozprofile 08:50:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:50:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:50:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:50:14 INFO - Running setup.py install for mozrunner 08:50:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:50:14 INFO - Running setup.py install for mozscreenshot 08:50:14 INFO - Running setup.py install for moztest 08:50:14 INFO - Running setup.py install for mozversion 08:50:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:50:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:50:14 INFO - Cleaning up... 08:50:14 INFO - Return code: 0 08:50:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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')]} 08:50:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:15 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 0x1043b1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043c1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5a0d58bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104250e00>, '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 0x1040b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10424bb20>, '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.CTFaoSkxjX/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.UdLVHZadaP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 08:50:15 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 08:50:15 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 08:50:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CTFaoSkxjX/Render', 08:50:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:15 INFO - 'HOME': '/Users/cltbld', 08:50:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:15 INFO - 'LOGNAME': 'cltbld', 08:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:15 INFO - 'MOZ_NO_REMOTE': '1', 08:50:15 INFO - 'NO_EM_RESTART': '1', 08:50:15 INFO - 'PAGER': '/bin/cat', 08:50:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:15 INFO - 'PWD': '/builds/slave/test', 08:50:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:15 INFO - 'SHELL': '/bin/bash', 08:50:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UdLVHZadaP/Listeners', 08:50:15 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 08:50:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:15 INFO - 'USER': 'cltbld', 08:50:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:15 INFO - 'XPC_FLAGS': '0x0', 08:50:15 INFO - 'XPC_SERVICE_NAME': '0', 08:50:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:50:15 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-YFztd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:50:15 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)) 08:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:50:15 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-K8CPak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:50:15 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)) 08:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:50:15 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-zmgTZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:50:15 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)) 08:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:50:15 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-py4Ylq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:50:16 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)) 08:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:50:16 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-EjB9BB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:50:16 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)) 08:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:50:16 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-bY38gz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:50:16 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)) 08:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:50:16 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-6VYrqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:50:16 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)) 08:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:50:16 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-A0XQna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:50:16 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)) 08:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:50:16 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-nVAEKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:50:16 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)) 08:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:50:16 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-9YHh8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:50:16 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)) 08:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:50:16 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-cpa3GD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:50:16 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)) 08:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:50:16 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-tdLpij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:50:16 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)) 08:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:50:16 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-yDj7eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:50:16 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)) 08:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:50:16 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-F4ChUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:50:17 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)) 08:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:17 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-fyHftT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:17 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)) 08:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:50:17 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-7PGGwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:50:17 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)) 08:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:50:17 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-eK3TLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:50:17 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)) 08:50:17 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)) 08:50:17 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)) 08:50:17 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)) 08:50:17 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)) 08:50:17 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)) 08:50:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:50:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:20 INFO - Downloading blessings-1.6.tar.gz 08:50:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:50:20 INFO - Installing collected packages: blessings 08:50:20 INFO - Running setup.py install for blessings 08:50:20 INFO - Successfully installed blessings 08:50:20 INFO - Cleaning up... 08:50:20 INFO - Return code: 0 08:50:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:50:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:50:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:50:21 INFO - Reading from file tmpfile_stdout 08:50:21 INFO - Current package versions: 08:50:21 INFO - blessings == 1.6 08:50:21 INFO - blobuploader == 1.2.4 08:50:21 INFO - docopt == 0.6.1 08:50:21 INFO - manifestparser == 1.1 08:50:21 INFO - mozInstall == 1.12 08:50:21 INFO - mozcrash == 0.17 08:50:21 INFO - mozdebug == 0.1 08:50:21 INFO - mozdevice == 0.48 08:50:21 INFO - mozfile == 1.2 08:50:21 INFO - mozhttpd == 0.7 08:50:21 INFO - mozinfo == 0.9 08:50:21 INFO - mozleak == 0.1 08:50:21 INFO - mozlog == 3.1 08:50:21 INFO - moznetwork == 0.27 08:50:21 INFO - mozprocess == 0.22 08:50:21 INFO - mozprofile == 0.28 08:50:21 INFO - mozrunner == 6.11 08:50:21 INFO - mozscreenshot == 0.1 08:50:21 INFO - mozsystemmonitor == 0.0 08:50:21 INFO - moztest == 0.7 08:50:21 INFO - mozversion == 1.4 08:50:21 INFO - psutil == 3.1.1 08:50:21 INFO - requests == 1.2.3 08:50:21 INFO - wsgiref == 0.1.2 08:50:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:21 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 0x1043b1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043c1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5a0d58bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104250e00>, '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 0x1040b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10424bb20>, '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.CTFaoSkxjX/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.UdLVHZadaP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 08:50:21 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 08:50:21 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 08:50:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CTFaoSkxjX/Render', 08:50:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:21 INFO - 'HOME': '/Users/cltbld', 08:50:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:21 INFO - 'LOGNAME': 'cltbld', 08:50:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:21 INFO - 'MOZ_NO_REMOTE': '1', 08:50:21 INFO - 'NO_EM_RESTART': '1', 08:50:21 INFO - 'PAGER': '/bin/cat', 08:50:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:21 INFO - 'PWD': '/builds/slave/test', 08:50:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:21 INFO - 'SHELL': '/bin/bash', 08:50:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UdLVHZadaP/Listeners', 08:50:21 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 08:50:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:21 INFO - 'USER': 'cltbld', 08:50:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:21 INFO - 'XPC_FLAGS': '0x0', 08:50:21 INFO - 'XPC_SERVICE_NAME': '0', 08:50:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:21 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)) 08:50:21 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)) 08:50:21 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)) 08:50:21 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)) 08:50:21 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)) 08:50:21 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)) 08:50:21 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)) 08:50:21 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)) 08:50:21 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)) 08:50:21 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)) 08:50:21 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)) 08:50:21 INFO - Cleaning up... 08:50:21 INFO - Return code: 0 08:50:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:50:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:21 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 0x1043b1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043c1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5a0d58bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104250e00>, '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 0x1040b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10424bb20>, '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.CTFaoSkxjX/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.UdLVHZadaP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 08:50:21 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 08:50:21 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 08:50:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CTFaoSkxjX/Render', 08:50:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:21 INFO - 'HOME': '/Users/cltbld', 08:50:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:21 INFO - 'LOGNAME': 'cltbld', 08:50:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:21 INFO - 'MOZ_NO_REMOTE': '1', 08:50:21 INFO - 'NO_EM_RESTART': '1', 08:50:21 INFO - 'PAGER': '/bin/cat', 08:50:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:21 INFO - 'PWD': '/builds/slave/test', 08:50:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:21 INFO - 'SHELL': '/bin/bash', 08:50:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UdLVHZadaP/Listeners', 08:50:21 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 08:50:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:21 INFO - 'USER': 'cltbld', 08:50:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:21 INFO - 'XPC_FLAGS': '0x0', 08:50:21 INFO - 'XPC_SERVICE_NAME': '0', 08:50:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:21 INFO - Downloading/unpacking jsonschema 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:50:24 INFO - Downloading/unpacking functools32 (from jsonschema) 08:50:24 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 08:50:24 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 08:50:24 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 08:50:24 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 08:50:24 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 08:50:24 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 08:50:24 INFO - Downloading functools32-3.2.3-2.tar.gz 08:50:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:50:24 INFO - warning: no files found matching '*.txt' 08:50:24 INFO - no previously-included directories found matching 'build' 08:50:24 INFO - no previously-included directories found matching 'dist' 08:50:24 INFO - no previously-included directories found matching '.git*' 08:50:24 INFO - Installing collected packages: jsonschema, functools32 08:50:24 INFO - Running setup.py install for functools32 08:50:24 INFO - warning: no files found matching '*.txt' 08:50:24 INFO - no previously-included directories found matching 'build' 08:50:24 INFO - no previously-included directories found matching 'dist' 08:50:24 INFO - no previously-included directories found matching '.git*' 08:50:24 INFO - Successfully installed jsonschema functools32 08:50:24 INFO - Cleaning up... 08:50:25 INFO - Return code: 0 08:50:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:50: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')]} 08:50:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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')]} 08:50:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:25 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 0x1043b1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043c1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5a0d58bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104250e00>, '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 0x1040b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10424bb20>, '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.CTFaoSkxjX/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.UdLVHZadaP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 08:50:25 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 08:50:25 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 08:50:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CTFaoSkxjX/Render', 08:50:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:25 INFO - 'HOME': '/Users/cltbld', 08:50:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:25 INFO - 'LOGNAME': 'cltbld', 08:50:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:25 INFO - 'MOZ_NO_REMOTE': '1', 08:50:25 INFO - 'NO_EM_RESTART': '1', 08:50:25 INFO - 'PAGER': '/bin/cat', 08:50:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:25 INFO - 'PWD': '/builds/slave/test', 08:50:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:25 INFO - 'SHELL': '/bin/bash', 08:50:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UdLVHZadaP/Listeners', 08:50:25 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 08:50:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:25 INFO - 'USER': 'cltbld', 08:50:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:25 INFO - 'XPC_FLAGS': '0x0', 08:50:25 INFO - 'XPC_SERVICE_NAME': '0', 08:50:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:25 INFO - Downloading/unpacking flake8 08:50:25 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 08:50:25 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 08:50:25 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 08:50:25 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 08:50:25 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 08:50:25 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 08:50:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:50:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:50:27 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 08:50:27 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 08:50:27 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 08:50:27 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 08:50:27 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 08:50:27 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 08:50:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:50:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:50:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:50:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:50:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:50:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:50:29 INFO - no previously-included directories found matching 'docs/_build' 08:50:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:50:29 INFO - Running setup.py install for pep8 08:50:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:50:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:50:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:50:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:50:29 INFO - no previously-included directories found matching 'docs/_build' 08:50:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:50:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:50:29 INFO - Cleaning up... 08:50:29 INFO - Return code: 0 08:50:29 INFO - Running post-action listener: _resource_record_post_action 08:50:29 INFO - Running post-action listener: _start_resource_monitoring 08:50:29 INFO - Starting resource monitoring. 08:50:29 INFO - ##### 08:50:29 INFO - ##### Running install step. 08:50:29 INFO - ##### 08:50:29 INFO - Running pre-action listener: _resource_record_pre_action 08:50:29 INFO - Running main action method: install 08:50:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:50:29 INFO - Reading from file tmpfile_stdout 08:50:29 INFO - Detecting whether we're running mozinstall >=1.0... 08:50:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:50:29 INFO - Reading from file tmpfile_stdout 08:50:29 INFO - Output received: 08:50:29 INFO - Usage: mozinstall [options] installer 08:50:29 INFO - Options: 08:50:29 INFO - -h, --help show this help message and exit 08:50:29 INFO - -d DEST, --destination=DEST 08:50:29 INFO - Directory to install application into. [default: 08:50:29 INFO - "/builds/slave/test"] 08:50:29 INFO - --app=APP Application being installed. [default: firefox] 08:50:29 INFO - mkdir: /builds/slave/test/build/application 08:50:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 08:50:51 INFO - Reading from file tmpfile_stdout 08:50:51 INFO - Output received: 08:50:51 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:50:51 INFO - Running post-action listener: _resource_record_post_action 08:50:51 INFO - ##### 08:50:51 INFO - ##### Running run-tests step. 08:50:51 INFO - ##### 08:50:51 INFO - Running pre-action listener: _resource_record_pre_action 08:50:51 INFO - Running main action method: run_tests 08:50:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:50:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:50:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:50:51 INFO - 2016-07-26 08:50:51.852 screenresolution[1640:7401] starting screenresolution argv=screenresolution get 08:50:51 INFO - 2016-07-26 08:50:51.855 screenresolution[1640:7401] Display 0: 1600x1200x32@60 08:50:51 INFO - 2016-07-26 08:50:51.861 screenresolution[1641:7404] starting screenresolution argv=screenresolution list 08:50:51 INFO - Available Modes on Display 0 08:50:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:50:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:50:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:50:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:50:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:50:52 INFO - Intel Iris: 08:50:52 INFO - Chipset Model: Intel Iris 08:50:52 INFO - Type: GPU 08:50:52 INFO - Bus: Built-In 08:50:52 INFO - VRAM (Dynamic, Max): 1536 MB 08:50:52 INFO - Vendor: Intel (0x8086) 08:50:52 INFO - Device ID: 0x0a2e 08:50:52 INFO - Revision ID: 0x0009 08:50:52 INFO - Displays: 08:50:52 INFO - Display: 08:50:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:50:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:50:52 INFO - Display Serial Number: 1600x1200 60 08:50:52 INFO - Main Display: Yes 08:50:52 INFO - Mirror: Off 08:50:52 INFO - Online: Yes 08:50:52 INFO - Rotation: Supported 08:50:52 INFO - Return code: 0 08:50:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:50:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:50:52 INFO - Python 2.7.3 08:50:52 INFO - Return code: 0 08:50:52 INFO - grabbing minidump binary from tooltool 08:50:52 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')]} 08:50:52 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 0x104250e00>, '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 0x1040b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10424bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:50:52 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 08:50:52 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 08:50:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:50:52 INFO - Return code: 0 08:50:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:50:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:50:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:50:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:50:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:50:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:50:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:50:53 INFO - Return code: 0 08:50:53 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', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:50:53 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 --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0052 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:50:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CTFaoSkxjX/Render', 08:50:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:53 INFO - 'HOME': '/Users/cltbld', 08:50:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:53 INFO - 'LOGNAME': 'cltbld', 08:50:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:50:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:50:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:53 INFO - 'MOZ_NO_REMOTE': '1', 08:50:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:50:53 INFO - 'NO_EM_RESTART': '1', 08:50:53 INFO - 'PAGER': '/bin/cat', 08:50:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:53 INFO - 'PWD': '/builds/slave/test', 08:50:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:50:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:53 INFO - 'SHELL': '/bin/bash', 08:50:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UdLVHZadaP/Listeners', 08:50:53 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 08:50:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:53 INFO - 'USER': 'cltbld', 08:50:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:53 INFO - 'XPC_FLAGS': '0x0', 08:50:53 INFO - 'XPC_SERVICE_NAME': '0', 08:50:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:50:53 INFO - mozversion application_buildid: 20160726073802 08:50:53 INFO - mozversion application_changeset: 958cee08361af9ed370be06695973bcda3d3aa46 08:50:53 INFO - mozversion application_display_name: Firefox 08:50:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:50:53 INFO - mozversion application_name: Firefox 08:50:53 INFO - mozversion application_remotingname: firefox 08:50:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:50:53 INFO - mozversion application_vendor: Mozilla 08:50:53 INFO - mozversion application_version: 48.0 08:50:53 INFO - mozversion platform_buildid: 20160726073802 08:50:53 INFO - mozversion platform_changeset: 958cee08361af9ed370be06695973bcda3d3aa46 08:50:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:50:53 INFO - mozversion platform_version: 48.0 08:50:53 INFO - using testdate: 1469548253 08:50:53 INFO - actual date: 1469548253 08:50:53 INFO - starting webserver on 'localhost:49275' 08:50:53 INFO - SUITE-START | Running 2 tests 08:50:53 INFO - TEST-START | dromaeo_css 08:50:53 INFO - operating with platform_type : mac_ 08:50:53 INFO - Initialising browser for dromaeo_css test... 08:50:53 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpGyDuKd/profile http://localhost:49275/getInfo.html) 08:50:55 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 08:50:55 INFO - PROCESS | 1662 | colorDepth:24 08:50:55 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 08:50:55 INFO - PROCESS | 1662 | __metrics 08:50:56 INFO - PROCESS | 1662 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:50:56 ERROR - PROCESS | 1662 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:50:56 INFO - TEST-INFO | 1662: exit 0 08:50:56 INFO - Browser initialized. 08:50:56 INFO - Running cycle 1/1 for dromaeo_css test... 08:50:56 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpGyDuKd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:51:08 INFO - PROCESS | 1665 | RSS: Main: 160178176 08:51:08 INFO - PROCESS | 1665 | 08:51:59 INFO - PROCESS | 1665 | 1469548319681 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] 08:54:09 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 08:54:11 INFO - PROCESS | 1665 | RSS: Main: 250707968 08:54:11 INFO - PROCESS | 1665 | 08:57:13 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 08:57:14 INFO - PROCESS | 1665 | RSS: Main: 311259136 08:57:14 INFO - PROCESS | 1665 | 09:00:16 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 09:00:16 INFO - PROCESS | 1665 | RSS: Main: 307724288 09:00:16 INFO - PROCESS | 1665 | 09:03:18 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 09:03:19 INFO - PROCESS | 1665 | RSS: Main: 310652928 09:03:19 INFO - PROCESS | 1665 | 09:06:22 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 09:06:23 INFO - PROCESS | 1665 | RSS: Main: 272449536 09:06:23 INFO - PROCESS | 1665 | 09:09:25 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 09:09:26 INFO - PROCESS | 1665 | RSS: Main: 319918080 09:09:26 INFO - PROCESS | 1665 | 09:09:26 INFO - PROCESS | 1665 | __start_tp_report 09:09:26 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 09:09:26 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 09:09:26 INFO - PROCESS | 1665 | |i|pagename|runs| 09:09:26 INFO - PROCESS | 1665 | |0;dojo.html;3290.9506357404634;3573.731970102243;3580.0154957386717;3591.4792355108502;3648.543932008499;5776.075827867542;5791.884162316762;5803.129530570416;5812.651240925547;5828.446297601727;5765.942340576593;5827.096799995997;5833.358330583633;5837.562182836283;5837.766489340422;5236.874072074504;5252.52727254548;5260;5295.338082739658;5342.626016178869;5309.787608495655;5370.3287089113865;5381.81163659272;5385.649932754359;5399.595030372738;5269.947300526984;5310.15037593985;5311.123664595337;5323.0152421801895;5362.892742145154;5320.494553017457;5369.865753356158;5372.409035006146;5383;5408.486193811621;5114.641975061747;5178.741062946875;5240.528352448298;5278.47215278473;5290.153575427951;5569.192467092249;5569.637973531708;5578.581606379537;5588.944110558883;5644.294463192101;6288.151099601541;6290.591111577733;6302.621842689453;6317.178766760338;6322.178116844827;6182.227221597301;6188.566800323979;6259;6263.530235232331;6285.591436556655;5896.882062358729;5905.084711869667;5905.379935106838;5910.172575839386;5923.229980102602;6292.244930608264;6312.084747711648;6322.4942004639515;6330.873382532415;6334.873302533923;5139.8458046258675;6104.481119104837;6198.411150940653;6212;6212.1303017577575;6198.876022479615;6250.593711408744;6265.65538895356;6288.025356069817;6309.211348581427;6188.721507532172;6258;6263.592866463665;6265.96867015662;6285.088662143963;6106.066326226518;6256.937430625727;6287.968560157261;6291.465225455796;6296.244450665858;4939.259111133359;4963.6277279204205;5000.1749711297225;5011.523905228997;5027.974860125676;4028.154087641628;4285.849995250152;4452.554744525586;4500.2799552072165;4505.43682039745;5836.503897168788;5974.103884417372;5996.2504686914135;6008.969955150196;6050.667213303311;6157.568970172135;6221.2845522764555;6236.719347629368;6237.937620623827;6243.656598887105;5982;5982.162497250389;5984.744962607819;5988.401159883977;6048;5374.435684253097;5456.972715136479;5460.235567020621;5471.616986810965;5531.529819965348;6322.841928951721;6379.075034120119;6410.8717825643225;6426.1003459515705;6434;6240.344763799917;6244.094606282155;6249.312575616769;6257.56197066201;6268.404501572343;6253.968730156502;6348.93651063502;6408.198975128109;6428.035794630843;6444.323346048597;6173.69131543412;6267.185265915584;6275.5920865145445;6287.717052732546;6291;6175.536834737502;6234.064890266496;6245.750169993149;6251.374862513712;6253.843653908689;5676.460736230051;6079.452849243589;6095.146679464967;6135.233095863017;6201.937980620317;6178.907316390168;6204.81385558434;6205.441510264098;6218.06728990655;6224.751009959732;6011.90982135277;6117.357677443804;6118.418750218722;6130;6144.109104179958;6016.699165041818;6045.244344456943;6242.094896240111;6248.9062664059165;6255.186825712628;6063.393660633901;6084.087386892002;6086.684010764503;6104.938950610437;6136.846578835565 09:09:26 INFO - PROCESS | 1665 | |1;ext.html;533.9561157936236;544.5779520871326;575.9625624334416;577.0910815465642;639.1914228500947;32610.347793044155;33353.66646333536;33449.66550334496;33522.66477335226;33569.83215083927;34692;35137.472937905884;35172.824135879346;35995;41190.794046029805;9784.217262618991;9926.751831204241;9930.65242716505;9946.90053099467;9983.450910199936;9691.903080969207;9832.557534910946;9833.704988850346;9839.606415743361;9848.261380396463;9279.350445468819;12048.216865903732;12316;12320.95271901885;12337.568185113523;12007.639770806889;12076.758464830698;12142.939285303517;12173.330466824322;12178;11803.468843902045;11899.88100119005;11921.225120367148;11926.165168438212;11943.34311612861;40192.59807401918;40623.39064914029;40631.593684063075;40639.79680101581;40646.796766016276;3294.3081952789944;3343.966560334414;3431.4852772084137;3692.7599706019023;4038.454808600831;28969.85515072411;29810.701892981226;30072.8496357519;30226;30462.69537304621;2760.144355249879;2779.3607470281745;2792.0786140573564;2795.1335086123163;2816.8169069010655;498134;504761.4285785716;505330;509580.4520977371;514825;52482.21276680853;62691.373086268555;62712;63301.050484242776;63443;73352.63323683347;74445.62777186079;74616.62691686615;74707.62646186844;74755;17549.912250438665;18647.347342842935;18672.81327186738;18674.253029878924;18682.719759203625;14128.788068178985;14177.716445671029;14191.858081419261;14195.64510887236;14212.857871421153;18669.066546672613;20392.796072039386;20541.79458205399;20691.482712931997;21200.575988480145;8165.95917020423;8270.627821748036;8281.917180828115;8341.789425802168;8394.45436046655;977.1254727019278;1022.2486472442748;1131.1007748839527;1150.442035612744;1171.4084387384316;30231.395372092436;30710.078697639106;30937.535936960965;31095.911643092382;31667.84166079155;1184.3841202574786;1188.9227200231958;1198.0595232742255;1215.7143071378218;1268.4165283969294;14489.492867749577;15424.845751542565;16042.197890105448;16282.94160879539;16300.918495407446;619965;628728;630189.8490507518;630689;631064;63490.36509634937;65164;65472;65480.34519654838;65559.34440655628;1454.5999850041323;1479.408236705305;1503.8796896248273;1573.3077445923757;1596.7844341014047;25257.621135682613;32759.017229483154;33264.83367583147;33545.49681754727;34132.82933585316;59469;59947;59948;59970.901018464145;60305.69847150912;390753;402548;403010;415362;415364;25297.62053569235;28720.42559148847;28769.85615071911;29207.41585168242;29326.853365733034;44579.77710111429;45561.29684912173;45564.54435455603;46332.7683361581;46902.76548617235;36790;36802.26395472129;37143.071423214635;37171.62828371682;39681;38461.423078653286;38709.612903871726;38730.8380748578;39316.213675725754;39808.80095599504;38285.6171438282;38896.6110338893;38922;38964.80517597394;39410;33845.98462046142;33858.15354616154;34746.9575912723;34771;34913;25666.871665641553;25912.61131083073;25952.610710838973;26035.349116271485;26429.7357026435 09:09:26 INFO - PROCESS | 1665 | |2;jquery.html;416.209202515221;416.35672885392074;419.572036522747;421.8207261913688;430.9159713855797;21004.68492972605;21328.81464375331;21580.244691435804;21721.153701935335;22261.888690556563;18141;21268.361949141512;21498.785012149874;21806.45483862904;21808.8909555452;5716.22830917827;5874.5006674432725;5879.588428809985;6139.416755408251;6155.01519756839;4335.978320108395;4706.341112244271;5744.368119506851;6056.152138700585;6182.72177752;6140.662263575501;6822.7612033578835;6835.58986460814;6837.418819400357;6862.313768623148;6553.868922621545;6808;6844.076049733272;6851.897221541681;6863.176418829722;4050.574689657573;5607.579431542651;6021.09683547467;6028.156058151862;6050.425209605124;26413.867930660224;27002.5949610756;27273.863630681917;27746.02888898899;27781.305467363276;2355.093289083698;2376.6910301660673;2436.4152603375064;2543.1988923489225;2802.4395120975682;14901.478448254258;15019.849801501954;15117.244137793066;15713.978591391522;16046.679066418606;1772.5745821002995;1776.404904357042;1822.6719190545696;1862.0317434933893;1864.6643604151247;104614.47692761563;107337.46331268371;108714;109958.45020774845;112340;11253.943730281297;11479.13906457019;11660.00889924366;11669.416529173677;11785.233959792586;14563.490277840225;14631.707365852624;14658.047226930428;14698.41206351734;14703.55889323322;7232.457565682595;9289.628414863464;9292;9393.62425502986;9410.341276110606;9254.583543740548;9262.397944133745;9296.349255552183;9349.766255843659;9355.906440935503;4007.238624661305;4119.752814831119;4785.306130611042;4900.240462728283;4903.485134060944;1752.3954235788633;1806.4667980817353;1954.853385996056;1994.9501262468264;2068.3588087692865;893.2853717026353;959.4531117263093;965.1217392173089;971.8396464583265;1100.5432745410565;16321;20712.792872071088;21035.78964210369;21072.367828965154;21357.359279221648;915.4598786715869;1000.2498126405196;1006.7785087280787;1073.1951036722458;1078.660222030058;7975.84048319042;9731.318807683536;11504.309741415542;11541.422928853692;11600.187986841009;624726;638369;638983;652576;654932;127498;134922;135970;141601;142405;1006.4866917871792;1022.7085280694967;1025.3950169400089;1026.6868605075374;1071.1002757683427;18562.628747425246;18893.71659425082;19117.13972871196;19121;19405.611887762447;55695.72152139214;56005.15992260201;57000;57624;58640;81321;83232;84408.57795711228;84936.30127397295;87544.5622771882;8550.700725474579;8580.742577722678;8582.184692454206;8649.956750216208;8803.647854085764;9487.288453365887;12409.131360804657;13249.602511924657;13618.591442256748;13737.450501979809;11382.54469821231;11723.472443740222;11731;11862.051035917279;12068.275903445821;9923.454210018519;9928.305018648625;11500.424978750862;11512.59705910289;11770.999465045566;11815.586454474053;11918;11981.64055078349;12058.698532536757;12200.389980500762;7456.7390141344795;8349.707760228363;8456.95771521163;8465.576721163794;9104.408213466104;10189.184865210616;11778.587749428729;11785.351805650429;11877.643670689893;11940.940295298815 09:09:26 INFO - PROCESS | 1665 | |3;mootools.html;1485.2351039214814;1624.204139971414;1654.495378909433;1964.0965156028226;2062.2060506704915;8304;8956.552172391379;9136.360454768168;9152.222061124812;9157.31320150988;8791.384603077788;9071.72784816455;9103.04418036105;9105.772355691095;9114.088591140882;2525.3686578355455;2549.757773011561;2557.9360515987064;2560.334313078604;2560.9231723048247;2499.662545556354;2564.948701025978;2572.4469239113682;2575.459153577751;2576.2013775729583;2530.8101892358054;2556.412025234188;2563.141347648531;2575.343287461704;2577.8066645001604;2529.6837895263093;2556.7059788124325;2571.7428257174133;2572.3954870605394;2573.7426257374204;2343.238447504568;2386.3556839653197;2388.9163879264315;2388.9522209555885;2391.868447235401;8836.983746869128;9063.09369063095;9150.816983660356;9218.81562368749;9222.492762898039;5541.251930989345;5676.148577713376;5746.109353050242;5764.538836893039;5766.682832444214;3595.1551385424405;3672.008557689409;3746.9063273418383;3757.812109394519;3764.5858955514873;1036.9014943580348;1042.888028061011;1061.601899287767;1069.9304545204614;1097.358045543358;12187.451564679523;12447.3776311185;12448.564300249447;12466.563670271587;12471.501139954391;4693.577578017995;4769.475357710649;4788.377510923558;4826.927596086061;4850.733209673432;8113.5131892086665;9644.228461723045;9651.131398174057;9658.034196580285;9659.71020869375;5474.507294343528;5501.119820828648;5519.116941289455;5529.060059789846;5549.38956714761;4561.087782443525;4681.81272749093;4684.508126646653;4708.246680531167;5140.074786538385;3502.649735026477;3675.5589329280656;3955.149642826806;4036.65688416482;4066.9186616267507;1236.8515778106505;1244.7012716947868;1248.4257241668752;1256.4408838067154;1261.8864302212844;862.3403096631082;908.5003248213588;937.8921424036323;989.6536212325628;1039.0233180810014;6023.216981792339;6122.479589234876;6209.534284928648;6216.036514340284;6257.687115644199;950.2777888804559;992.6476100984191;997.546116516983;1035.7203555040096;1049.3651340938623;4050.25070361984;4121.29937910556;4139.9793001035405;4167.458230430025;4202.222588821078;10908.836367454494;11356.659300221007;11428.714282142846;11455.656330310105;11457.656270311903;11170.944145279384;11179.4969226385;11188.944055279835;11199.776004479865;11272.380019098864;7282.96358518204;8156.592170391456;8451.45065570736;8528.317734581218;8545.102764209792;5903.734331955158;6032.306284777307;6040.607360521728;6192.783252586138;6212.192414986023;9873.753156171153;9881.604735810488;10059.39643621385;10062.69811905644;10063.345882517613;9694.079062489052;10219.795604087727;10244.538995745359;10345;10398.636047738293;6818.522703410912;7734.574598397142;7764.34003109742;7872.212778722082;7888.092869320101;7584.734534291273;8605.096464871349;8617.48295102296;8623.741287761377;8627;7426.554406735613;7462.253774622494;7593.278638529331;7742.225777422213;7753.418493612889;7479.439042071976;7513.849723005618;7571;7571.848563028819;7592.696292148473;7194.820129496805;7262.709491620276;7274.272572742683;7296.051513303237;7369.705211791468;4963.9575689105695;5046.268291097696;5069.340985671986;5084.796608135781;5137.897242055213;4385.144896745104;4960.107180707508;5051.823186188466;5159.716215608028;5289.973550132225 09:09:26 INFO - PROCESS | 1665 | |4;prototype.html;331.74787161757064;337.0848147280134;341.92135808763976;346.27628256942984;349.067988470783;5497.752601132948;6551.017347397887;6588.538802283836;6600.933990660098;6652.2349929757975;5460.7440288733615;6548.836279093025;6566.080748695186;6611.338866113386;6631.171103612049;4089.407035979781;4713.363695901044;4767.451743049559;4928.5564299213065;4998.350214472113;4885.853424397274;4945.035718034985;4954.777035033414;4972.279019542164;4973.502649735034;4881.560659540658;4889.119958407486;4911.287863259825;4915.115279249733;4923.236898280772;4661.88345291367;4728.054389122172;4914.189158788796;4917.655764096515;4924.089043526923;3561.857525698969;4188.267053265667;4201.1807697499;4226.175895700339;4249.320108782611;6224.253089629228;6226.25284965807;6240.31356550779;6264;6266.4360207581085;5774.740136693859;5781.566382521328;5798.507126894219;5798.884022319572;5826.009578371687;6746.190457145125;7009.1589009319205;7021.61381124038;7033.331833475811;7038.085048943656;4097.508299004138;4641.630718937921;4748.430188377417;4760.571548560646;4765;7395.926040739578;7443.8883416748795;7448;7458.067741532309;7464.850702985964;4833.347498087784;4846.491118432585;4855.344528488608;4861.854144375674;4865.829695960624;4924.75376231187;4925.064237794808;4935.654504184673;4935.876603084952;4936;4884.4871288514905;5565.886822635489;5830.3586605473365;5833.300003999547;5844.357120716718;6692.196936367667;7076.540024898468;7083.079199704005;7111.53775004623;7116.146062472537;1669.7996240451223;1705.2326453096157;1709.9572510687083;1711.9486415407557;1716.7081596128687;1033.788073444942;1046.2519298701466;1083.3391631105019;1086.9782604347868;1110.9777804443866;6596.472282217411;6649.035889795952;6669.233038200572;6694.698738556776;6709.865802683919;7363.631818409165;7373.29953654402;7380.335769780745;7408.777736667908;7510.699572017167;6804.387605115563;6815.659217039129;6821.590704557742;6828.283030281848;6834.863302733917;3761.078535758702;3857.1707082977296;3905.179912218466;3915.5888631693833;3919.353306704362;7829.295363417206;7866.842663146705;7872.606369681493;7880.3301719354495;7895.881561776578;7566.659500322498;7636.69453221876;7640.465167438337;7651.311381975537;7676.385889128856;7258.927410725931;7790.922090779133;7821.178776228414;7821.335186509211;7829.177936316719;7070.222275549582;7403.14863790671;7419.109706835215;7432.030511914239;7443.218462061405;7257.237990011184;7282.817929551804;7305.452091093083;7338.96330518344;7344.816379590339;7809.609519523888;7814.140444551209;7831.843363132592;7858.5677787722225;7877.409194310335;4653.46485154198;4704.035672687022;4706.717596944194;4717.764111794328;4725.243960966229;7028.929710702828;7331.486795924234;7387.482876198615;7393.519421237817;7405.925940740523;7095.893561596684;7136.964315178391;7137.250588688321;7143.571385716874;7167.921302822123;7124.358807707331;7137.714491420285;7148.213696493485;7152.9270609409;7162.570245785061;7010.123734533184;7016.649167541705;7020.473464490286;7022.473314501535;7036.9296307036275;6827.283135270725;7127.2516385778745;7133.108361454818;7139.643017848983;7153.570785752663;5620.269364982526;6695.263521012782;6805.1833779944745;6916.827079323057;6991.2659170788365 09:09:26 INFO - PROCESS | 1665 | |5;yui.html;713.6467448612938;723.6562632749444;745.6197339356933;765.1850778920449;816.9468984516004;15411.614709632266;15693.764593531077;15748.685026299467;15803.130827804465;15804.60488487787;14539.273036348193;14610;14623.976321657488;14625.488107916199;14628.853711462882;768.7885831396355;780.3016300411128;845.8096928191154;935.8315503209419;961.7932144588912;942.6889126588244;943.259541260111;952.3999880075543;953.980920381592;956.2636769687336;1009.9141572966307;1017.0236572889997;1018.9643362482315;1020.2959957629212;1021.3310281765456;807.0557447786105;817.4114637461018;818.4475479051616;820.3560205238919;1007.7531004903772;748.0350348051007;752.5108679358406;764.6711913877031;765.0742601452249;765.544501021891;15214.239288035664;15247;15270.31283592241;15271.38914443421;15335.386584536605;12847.164934279243;12993.155444896052;13223.33883305831;13290.401931913088;13320.800187997187;10159.796804063952;10197.694069177936;10198.184145268435;10237.64168254115;10709.839352409721;3568.37553428149;3575.3564358415474;3604.4052731299566;3661.761985470936;3832.1760821423527;76244.61877690631;76344.61827690882;77779.83330250051;77927;78361.99999999943;9535.427874327563;9629;9643.421394716339;9718.611255549698;10066.396016238903;22062.33812985613;22966.425839353815;22977.965991530422;23044.423889402562;23131.7277549733;7663.655135518915;7667.693292268247;7684.807879802938;7712.8457430852195;7766.262205090507;4219.409282700424;4251.234777739975;4270.12462445198;4371;4432.113577284492;3817.8091095445116;3863.1887303666545;3866.4007078902814;3867.1105645701646;3867.16855875988;639.0956796133512;665.6505334699225;666.9166354205724;671.2247354305784;671.3890359772583;557.7768892443055;608.2305883057935;617.2500411999442;620.3331418724889;633.7274971762095;7573.35626471745;8386.245237928615;8507.872381914276;8573.056963733985;8593.52735599548;517.5057819782099;548.775002249084;607.1954660075418;610.914471973924;632.8512799492115;3719.237556300952;3817.408301713239;3830.7701537907815;3929.096307849211;4054;95147.57278640688;95526;95911.04088959021;96719;97010;80414;80830.19169808227;81833.9541511467;81921.18078819136;83486.58256708678;67452;73744;73822.2617773826;74526.62736686281;75877;8460.196281353261;8542.530160841214;8655.394122411371;8676.479411235094;8721.302295816193;48331.275030875266;51207.23189152091;51777;52320;53231.41070187729;55444;70501.58996819932;72791;73815.261847383;75090;11218.326900386002;11344.376059316817;11524.769504609692;11761.647150585497;11823.349715765371;12005.519779208735;12089.57686480969;12259.218904627382;12312.630621081023;12890.226586404846;11596.844558656427;11686.649400517997;11850.822237666614;11872.703182420508;11898.183704206147;11454.656360309204;11873.762524749283;11898.497835865313;11935.104867135173;12024.639260822189;11485.425728713699;11697.122715796178;11834;12023.75952480963;12086.274823510617;9889.55497002651;10055.798884022131;10128.59485620567;10168.33905796121;10423.374597524173;9698.806023879624;9935.533934220806;9953.701388958343;10009.697391650123;10051.346662466916 09:09:26 INFO - PROCESS | 1665 | __end_tp_report 09:09:26 INFO - PROCESS | 1665 | __start_cc_report 09:09:26 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1167 09:09:26 INFO - PROCESS | 1665 | __end_cc_report 09:09:26 INFO - PROCESS | 1665 | __startTimestamp1469549366162__endTimestamp 09:09:26 INFO - PROCESS | 1665 | 09:09:26 INFO - PROCESS | 1665 | ------- Summary: start ------- 09:09:26 INFO - PROCESS | 1665 | Number of tests: 6 09:09:26 INFO - PROCESS | 1665 | 09:09:26 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5815.68 Median:6084.09 stddev:629.24 (10.3%) stddev-sans-first:599.19 09:09:26 INFO - PROCESS | 1665 | Values: 3291.0 3573.7 3580.0 3591.5 3648.5 5776.1 5791.9 5803.1 5812.7 5828.4 5765.9 5827.1 5833.4 5837.6 5837.8 5236.9 5252.5 5260.0 5295.3 5342.6 5309.8 5370.3 5381.8 5385.6 5399.6 5269.9 5310.2 5311.1 5323.0 5362.9 5320.5 5369.9 5372.4 5383.0 5408.5 5114.6 5178.7 5240.5 5278.5 5290.2 5569.2 5569.6 5578.6 5588.9 5644.3 6288.2 6290.6 6302.6 6317.2 6322.2 6182.2 6188.6 6259.0 6263.5 6285.6 5896.9 5905.1 5905.4 5910.2 5923.2 6292.2 6312.1 6322.5 6330.9 6334.9 5139.8 6104.5 6198.4 6212.0 6212.1 6198.9 6250.6 6265.7 6288.0 6309.2 6188.7 6258.0 6263.6 6266.0 6285.1 6106.1 6256.9 6288.0 6291.5 6296.2 4939.3 4963.6 5000.2 5011.5 5028.0 4028.2 4285.8 4452.6 4500.3 4505.4 5836.5 5974.1 5996.3 6009.0 6050.7 6157.6 6221.3 6236.7 6237.9 6243.7 5982.0 5982.2 5984.7 5988.4 6048.0 5374.4 5457.0 5460.2 5471.6 5531.5 6322.8 6379.1 6410.9 6426.1 6434.0 6240.3 6244.1 6249.3 6257.6 6268.4 6254.0 6348.9 6408.2 6428.0 6444.3 6173.7 6267.2 6275.6 6287.7 6291.0 6175.5 6234.1 6245.8 6251.4 6253.8 5676.5 6079.5 6095.1 6135.2 6201.9 6178.9 6204.8 6205.4 6218.1 6224.8 6011.9 6117.4 6118.4 6130.0 6144.1 6016.7 6045.2 6242.1 6248.9 6255.2 6063.4 6084.1 6086.7 6104.9 6136.8 09:09:26 INFO - PROCESS | 1665 | 09:09:26 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:66561.27 Median:34842.00 stddev:138957.54 (398.8%) stddev-sans-first:139258.92 09:09:26 INFO - PROCESS | 1665 | Values: 534.0 544.6 576.0 577.1 639.2 32610.3 33353.7 33449.7 33522.7 33569.8 34692.0 35137.5 35172.8 35995.0 41190.8 9784.2 9926.8 9930.7 9946.9 9983.5 9691.9 9832.6 9833.7 9839.6 9848.3 9279.4 12048.2 12316.0 12321.0 12337.6 12007.6 12076.8 12142.9 12173.3 12178.0 11803.5 11899.9 11921.2 11926.2 11943.3 40192.6 40623.4 40631.6 40639.8 40646.8 3294.3 3344.0 3431.5 3692.8 4038.5 28969.9 29810.7 30072.8 30226.0 30462.7 2760.1 2779.4 2792.1 2795.1 2816.8 498134.0 504761.4 505330.0 509580.5 514825.0 52482.2 62691.4 62712.0 63301.1 63443.0 73352.6 74445.6 74616.6 74707.6 74755.0 17549.9 18647.3 18672.8 18674.3 18682.7 14128.8 14177.7 14191.9 14195.6 14212.9 18669.1 20392.8 20541.8 20691.5 21200.6 8166.0 8270.6 8281.9 8341.8 8394.5 977.1 1022.2 1131.1 1150.4 1171.4 30231.4 30710.1 30937.5 31095.9 31667.8 1184.4 1188.9 1198.1 1215.7 1268.4 14489.5 15424.8 16042.2 16282.9 16300.9 619965.0 628728.0 630189.8 630689.0 631064.0 63490.4 65164.0 65472.0 65480.3 65559.3 1454.6 1479.4 1503.9 1573.3 1596.8 25257.6 32759.0 33264.8 33545.5 34132.8 59469.0 59947.0 59948.0 59970.9 60305.7 390753.0 402548.0 403010.0 415362.0 415364.0 25297.6 28720.4 28769.9 29207.4 29326.9 44579.8 45561.3 45564.5 46332.8 46902.8 36790.0 36802.3 37143.1 37171.6 39681.0 38461.4 38709.6 38730.8 39316.2 39808.8 38285.6 38896.6 38922.0 38964.8 39410.0 33846.0 33858.2 34747.0 34771.0 34913.0 25666.9 25912.6 25952.6 26035.3 26429.7 09:09:26 INFO - PROCESS | 1665 | 09:09:26 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:36880.72 Median:2365.89 stddev:106803.12 (4514.3%) stddev-sans-first:107067.64 09:09:26 INFO - PROCESS | 1665 | Values: 416.2 416.4 419.6 421.8 430.9 21004.7 21328.8 21580.2 21721.2 22261.9 18141.0 21268.4 21498.8 21806.5 21808.9 5716.2 5874.5 5879.6 6139.4 6155.0 4336.0 4706.3 5744.4 6056.2 6182.7 6140.7 6822.8 6835.6 6837.4 6862.3 6553.9 6808.0 6844.1 6851.9 6863.2 4050.6 5607.6 6021.1 6028.2 6050.4 26413.9 27002.6 27273.9 27746.0 27781.3 2355.1 2376.7 2436.4 2543.2 2802.4 14901.5 15019.8 15117.2 15714.0 16046.7 1772.6 1776.4 1822.7 1862.0 1864.7 104614.5 107337.5 108714.0 109958.5 112340.0 11253.9 11479.1 11660.0 11669.4 11785.2 14563.5 14631.7 14658.0 14698.4 14703.6 7232.5 9289.6 9292.0 9393.6 9410.3 9254.6 9262.4 9296.3 9349.8 9355.9 4007.2 4119.8 4785.3 4900.2 4903.5 1752.4 1806.5 1954.9 1995.0 2068.4 893.3 959.5 965.1 971.8 1100.5 16321.0 20712.8 21035.8 21072.4 21357.4 915.5 1000.2 1006.8 1073.2 1078.7 7975.8 9731.3 11504.3 11541.4 11600.2 624726.0 638369.0 638983.0 652576.0 654932.0 127498.0 134922.0 135970.0 141601.0 142405.0 1006.5 1022.7 1025.4 1026.7 1071.1 18562.6 18893.7 19117.1 19121.0 19405.6 55695.7 56005.2 57000.0 57624.0 58640.0 81321.0 83232.0 84408.6 84936.3 87544.6 8550.7 8580.7 8582.2 8650.0 8803.6 9487.3 12409.1 13249.6 13618.6 13737.5 11382.5 11723.5 11731.0 11862.1 12068.3 9923.5 9928.3 11500.4 11512.6 11771.0 11815.6 11918.0 11981.6 12058.7 12200.4 7456.7 8349.7 8457.0 8465.6 9104.4 10189.2 11778.6 11785.4 11877.6 11940.9 09:09:26 INFO - PROCESS | 1665 | 09:09:26 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:5875.26 Median:4962.03 stddev:3274.38 (66.0%) stddev-sans-first:3266.94 09:09:26 INFO - PROCESS | 1665 | Values: 1485.2 1624.2 1654.5 1964.1 2062.2 8304.0 8956.6 9136.4 9152.2 9157.3 8791.4 9071.7 9103.0 9105.8 9114.1 2525.4 2549.8 2557.9 2560.3 2560.9 2499.7 2564.9 2572.4 2575.5 2576.2 2530.8 2556.4 2563.1 2575.3 2577.8 2529.7 2556.7 2571.7 2572.4 2573.7 2343.2 2386.4 2388.9 2389.0 2391.9 8837.0 9063.1 9150.8 9218.8 9222.5 5541.3 5676.1 5746.1 5764.5 5766.7 3595.2 3672.0 3746.9 3757.8 3764.6 1036.9 1042.9 1061.6 1069.9 1097.4 12187.5 12447.4 12448.6 12466.6 12471.5 4693.6 4769.5 4788.4 4826.9 4850.7 8113.5 9644.2 9651.1 9658.0 9659.7 5474.5 5501.1 5519.1 5529.1 5549.4 4561.1 4681.8 4684.5 4708.2 5140.1 3502.6 3675.6 3955.1 4036.7 4066.9 1236.9 1244.7 1248.4 1256.4 1261.9 862.3 908.5 937.9 989.7 1039.0 6023.2 6122.5 6209.5 6216.0 6257.7 950.3 992.6 997.5 1035.7 1049.4 4050.3 4121.3 4140.0 4167.5 4202.2 10908.8 11356.7 11428.7 11455.7 11457.7 11170.9 11179.5 11188.9 11199.8 11272.4 7283.0 8156.6 8451.5 8528.3 8545.1 5903.7 6032.3 6040.6 6192.8 6212.2 9873.8 9881.6 10059.4 10062.7 10063.3 9694.1 10219.8 10244.5 10345.0 10398.6 6818.5 7734.6 7764.3 7872.2 7888.1 7584.7 8605.1 8617.5 8623.7 8627.0 7426.6 7462.3 7593.3 7742.2 7753.4 7479.4 7513.8 7571.0 7571.8 7592.7 7194.8 7262.7 7274.3 7296.1 7369.7 4964.0 5046.3 5069.3 5084.8 5137.9 4385.1 4960.1 5051.8 5159.7 5290.0 09:09:26 INFO - PROCESS | 1665 | 09:09:26 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:5839.82 Median:6640.10 stddev:1870.65 (28.2%) stddev-sans-first:1829.65 09:09:26 INFO - PROCESS | 1665 | Values: 331.7 337.1 341.9 346.3 349.1 5497.8 6551.0 6588.5 6600.9 6652.2 5460.7 6548.8 6566.1 6611.3 6631.2 4089.4 4713.4 4767.5 4928.6 4998.4 4885.9 4945.0 4954.8 4972.3 4973.5 4881.6 4889.1 4911.3 4915.1 4923.2 4661.9 4728.1 4914.2 4917.7 4924.1 3561.9 4188.3 4201.2 4226.2 4249.3 6224.3 6226.3 6240.3 6264.0 6266.4 5774.7 5781.6 5798.5 5798.9 5826.0 6746.2 7009.2 7021.6 7033.3 7038.1 4097.5 4641.6 4748.4 4760.6 4765.0 7395.9 7443.9 7448.0 7458.1 7464.9 4833.3 4846.5 4855.3 4861.9 4865.8 4924.8 4925.1 4935.7 4935.9 4936.0 4884.5 5565.9 5830.4 5833.3 5844.4 6692.2 7076.5 7083.1 7111.5 7116.1 1669.8 1705.2 1710.0 1711.9 1716.7 1033.8 1046.3 1083.3 1087.0 1111.0 6596.5 6649.0 6669.2 6694.7 6709.9 7363.6 7373.3 7380.3 7408.8 7510.7 6804.4 6815.7 6821.6 6828.3 6834.9 3761.1 3857.2 3905.2 3915.6 3919.4 7829.3 7866.8 7872.6 7880.3 7895.9 7566.7 7636.7 7640.5 7651.3 7676.4 7258.9 7790.9 7821.2 7821.3 7829.2 7070.2 7403.1 7419.1 7432.0 7443.2 7257.2 7282.8 7305.5 7339.0 7344.8 7809.6 7814.1 7831.8 7858.6 7877.4 4653.5 4704.0 4706.7 4717.8 4725.2 7028.9 7331.5 7387.5 7393.5 7405.9 7095.9 7137.0 7137.3 7143.6 7167.9 7124.4 7137.7 7148.2 7152.9 7162.6 7010.1 7016.6 7020.5 7022.5 7036.9 6827.3 7127.3 7133.1 7139.6 7153.6 5620.3 6695.3 6805.2 6916.8 6991.3 09:09:26 INFO - PROCESS | 1665 | 09:09:26 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:18815.36 Median:26147.25 stddev:26309.90 (100.6%) stddev-sans-first:26348.60 09:09:26 INFO - PROCESS | 1665 | Values: 713.6 723.7 745.6 765.2 816.9 15411.6 15693.8 15748.7 15803.1 15804.6 14539.3 14610.0 14624.0 14625.5 14628.9 768.8 780.3 845.8 935.8 961.8 942.7 943.3 952.4 954.0 956.3 1009.9 1017.0 1019.0 1020.3 1021.3 807.1 817.4 818.4 820.4 1007.8 748.0 752.5 764.7 765.1 765.5 15214.2 15247.0 15270.3 15271.4 15335.4 12847.2 12993.2 13223.3 13290.4 13320.8 10159.8 10197.7 10198.2 10237.6 10709.8 3568.4 3575.4 3604.4 3661.8 3832.2 76244.6 76344.6 77779.8 77927.0 78362.0 9535.4 9629.0 9643.4 9718.6 10066.4 22062.3 22966.4 22978.0 23044.4 23131.7 7663.7 7667.7 7684.8 7712.8 7766.3 4219.4 4251.2 4270.1 4371.0 4432.1 3817.8 3863.2 3866.4 3867.1 3867.2 639.1 665.7 666.9 671.2 671.4 557.8 608.2 617.3 620.3 633.7 7573.4 8386.2 8507.9 8573.1 8593.5 517.5 548.8 607.2 610.9 632.9 3719.2 3817.4 3830.8 3929.1 4054.0 95147.6 95526.0 95911.0 96719.0 97010.0 80414.0 80830.2 81834.0 81921.2 83486.6 67452.0 73744.0 73822.3 74526.6 75877.0 8460.2 8542.5 8655.4 8676.5 8721.3 48331.3 51207.2 51777.0 52320.0 53231.4 55444.0 70501.6 72791.0 73815.3 75090.0 11218.3 11344.4 11524.8 11761.6 11823.3 12005.5 12089.6 12259.2 12312.6 12890.2 11596.8 11686.6 11850.8 11872.7 11898.2 11454.7 11873.8 11898.5 11935.1 12024.6 11485.4 11697.1 11834.0 12023.8 12086.3 9889.6 10055.8 10128.6 10168.3 10423.4 9698.8 9935.5 9953.7 10009.7 10051.3 09:09:26 INFO - PROCESS | 1665 | -------- Summary: end -------- 09:09:26 INFO - PROCESS | 1665 | 09:09:26 INFO - TEST-INFO | 1665: exit 0 09:09:26 INFO - TEST-OK | dromaeo_css | took 1112971ms 09:09:26 INFO - TEST-START | kraken 09:09:26 INFO - operating with platform_type : mac_ 09:09:26 INFO - Initialising browser for kraken test... 09:09:26 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmp1n1Vno/profile http://localhost:49275/getInfo.html) 09:09:28 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 09:09:28 INFO - PROCESS | 1671 | colorDepth:24 09:09:28 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 09:09:28 INFO - PROCESS | 1671 | __metrics 09:09:29 INFO - PROCESS | 1671 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:09:29 ERROR - PROCESS | 1671 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:09:29 INFO - TEST-INFO | 1671: exit 0 09:09:29 INFO - Browser initialized. 09:09:29 INFO - Running cycle 1/1 for kraken test... 09:09:29 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmp1n1Vno/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:09:41 INFO - PROCESS | 1674 | RSS: Main: 160456704 09:09:41 INFO - PROCESS | 1674 | 09:09:44 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 09:09:45 INFO - PROCESS | 1674 | RSS: Main: 224124928 09:09:45 INFO - PROCESS | 1674 | 09:09:47 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 09:09:48 INFO - PROCESS | 1674 | RSS: Main: 239349760 09:09:48 INFO - PROCESS | 1674 | 09:09:51 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 09:09:52 INFO - PROCESS | 1674 | RSS: Main: 325451776 09:09:52 INFO - PROCESS | 1674 | 09:09:54 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 09:09:54 INFO - PROCESS | 1674 | RSS: Main: 230363136 09:09:54 INFO - PROCESS | 1674 | 09:09:56 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:09:57 INFO - PROCESS | 1674 | RSS: Main: 230936576 09:09:57 INFO - PROCESS | 1674 | 09:10:00 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 09:10:00 INFO - PROCESS | 1674 | RSS: Main: 268627968 09:10:00 INFO - PROCESS | 1674 | 09:10:03 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 09:10:04 INFO - PROCESS | 1674 | RSS: Main: 270823424 09:10:04 INFO - PROCESS | 1674 | 09:10:07 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 09:10:07 INFO - PROCESS | 1674 | RSS: Main: 268681216 09:10:07 INFO - PROCESS | 1674 | 09:10:09 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:10:09 INFO - PROCESS | 1674 | RSS: Main: 260702208 09:10:09 INFO - PROCESS | 1674 | 09:10:11 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:10:12 INFO - PROCESS | 1674 | RSS: Main: 268488704 09:10:12 INFO - PROCESS | 1674 | 09:10:14 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:10:15 INFO - PROCESS | 1674 | RSS: Main: 271171584 09:10:15 INFO - PROCESS | 1674 | 09:10:17 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:10:18 INFO - PROCESS | 1674 | RSS: Main: 278376448 09:10:18 INFO - PROCESS | 1674 | 09:10:21 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:10:21 INFO - PROCESS | 1674 | RSS: Main: 275415040 09:10:21 INFO - PROCESS | 1674 | 09:10:23 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 09:10:23 INFO - PROCESS | 1674 | RSS: Main: 336912384 09:10:23 INFO - PROCESS | 1674 | 09:10:23 INFO - PROCESS | 1674 | __start_tp_report 09:10:23 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 09:10:23 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 09:10:23 INFO - PROCESS | 1674 | |i|pagename|runs| 09:10:23 INFO - PROCESS | 1674 | |0;ai-astar;113;113;119;113;113;111;114;114;113;135 09:10:23 INFO - PROCESS | 1674 | |1;audio-beat-detection;163;139;170;165;118;139;140;117;168;120 09:10:23 INFO - PROCESS | 1674 | |2;audio-dft;183;185;196;257;204;186;184;186;186;184 09:10:23 INFO - PROCESS | 1674 | |3;audio-fft;72;77;75;152;56;55;57;62;127;56 09:10:23 INFO - PROCESS | 1674 | |4;audio-oscillator;88;90;142;80;82;96;126;80;78;125 09:10:23 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;89;87;90;87;93;126;122;87;91;86 09:10:23 INFO - PROCESS | 1674 | |6;imaging-darkroom;94;94;94;96;94;94;94;93;93;94 09:10:23 INFO - PROCESS | 1674 | |7;imaging-desaturate;87;86;98;135;126;84;84;83;85;87 09:10:23 INFO - PROCESS | 1674 | |8;json-parse-financial;60;62;62;62;63;62;62;77;59;56 09:10:23 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;63;64;65;74;75;71;66;66;66;66 09:10:23 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;81;79;80;78;79;79;77;79;79;98 09:10:23 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;125;127;127;127;125;127;125;123;145;138 09:10:23 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;166;165;164;166;167;166;163;161;168;166 09:10:23 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;66;68;68;66;67;66;68;68;68;66 09:10:23 INFO - PROCESS | 1674 | __end_tp_report 09:10:23 INFO - PROCESS | 1674 | __start_cc_report 09:10:23 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1930 09:10:23 INFO - PROCESS | 1674 | __end_cc_report 09:10:23 INFO - PROCESS | 1674 | __startTimestamp1469549423755__endTimestamp 09:10:23 INFO - PROCESS | 1674 | 09:10:23 INFO - PROCESS | 1674 | ------- Summary: start ------- 09:10:23 INFO - PROCESS | 1674 | Number of tests: 14 09:10:23 INFO - PROCESS | 1674 | 09:10:23 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:115.80 Median:113.50 stddev:7.05 (6.2%) stddev-sans-first:7.41 09:10:23 INFO - PROCESS | 1674 | Values: 113.0 113.0 119.0 113.0 113.0 111.0 114.0 114.0 113.0 135.0 09:10:23 INFO - PROCESS | 1674 | 09:10:23 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:143.90 Median:151.50 stddev:21.35 (14.1%) stddev-sans-first:21.49 09:10:23 INFO - PROCESS | 1674 | Values: 163.0 139.0 170.0 165.0 118.0 139.0 140.0 117.0 168.0 120.0 09:10:23 INFO - PROCESS | 1674 | 09:10:23 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:195.10 Median:186.00 stddev:22.74 (12.2%) stddev-sans-first:23.70 09:10:23 INFO - PROCESS | 1674 | Values: 183.0 185.0 196.0 257.0 204.0 186.0 184.0 186.0 186.0 184.0 09:10:23 INFO - PROCESS | 1674 | 09:10:23 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:78.90 Median:59.50 stddev:33.51 (56.3%) stddev-sans-first:35.45 09:10:23 INFO - PROCESS | 1674 | Values: 72.0 77.0 75.0 152.0 56.0 55.0 57.0 62.0 127.0 56.0 09:10:23 INFO - PROCESS | 1674 | 09:10:23 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:98.70 Median:81.00 stddev:23.37 (28.9%) stddev-sans-first:24.47 09:10:23 INFO - PROCESS | 1674 | Values: 88.0 90.0 142.0 80.0 82.0 96.0 126.0 80.0 78.0 125.0 09:10:23 INFO - PROCESS | 1674 | 09:10:23 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:95.80 Median:88.00 stddev:15.05 (17.1%) stddev-sans-first:15.76 09:10:23 INFO - PROCESS | 1674 | Values: 89.0 87.0 90.0 87.0 93.0 126.0 122.0 87.0 91.0 86.0 09:10:23 INFO - PROCESS | 1674 | 09:10:23 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:94.00 Median:94.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 09:10:23 INFO - PROCESS | 1674 | Values: 94.0 94.0 94.0 96.0 94.0 94.0 94.0 93.0 93.0 94.0 09:10:23 INFO - PROCESS | 1674 | 09:10:23 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:85.50 stddev:19.04 (22.3%) stddev-sans-first:19.94 09:10:23 INFO - PROCESS | 1674 | Values: 87.0 86.0 98.0 135.0 126.0 84.0 84.0 83.0 85.0 87.0 09:10:23 INFO - PROCESS | 1674 | 09:10:23 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:62.00 stddev:5.50 (8.9%) stddev-sans-first:5.76 09:10:23 INFO - PROCESS | 1674 | Values: 60.0 62.0 62.0 62.0 63.0 62.0 62.0 77.0 59.0 56.0 09:10:23 INFO - PROCESS | 1674 | 09:10:23 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:66.00 stddev:4.20 (6.4%) stddev-sans-first:4.11 09:10:23 INFO - PROCESS | 1674 | Values: 63.0 64.0 65.0 74.0 75.0 71.0 66.0 66.0 66.0 66.0 09:10:23 INFO - PROCESS | 1674 | 09:10:23 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:79.00 stddev:6.10 (7.7%) stddev-sans-first:6.47 09:10:23 INFO - PROCESS | 1674 | Values: 81.0 79.0 80.0 78.0 79.0 79.0 77.0 79.0 79.0 98.0 09:10:23 INFO - PROCESS | 1674 | 09:10:23 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:127.00 stddev:6.97 (5.5%) stddev-sans-first:7.25 09:10:23 INFO - PROCESS | 1674 | Values: 125.0 127.0 127.0 127.0 125.0 127.0 125.0 123.0 145.0 138.0 09:10:23 INFO - PROCESS | 1674 | 09:10:23 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.20 Median:166.00 stddev:2.04 (1.2%) stddev-sans-first:2.15 09:10:23 INFO - PROCESS | 1674 | Values: 166.0 165.0 164.0 166.0 167.0 166.0 163.0 161.0 168.0 166.0 09:10:23 INFO - PROCESS | 1674 | 09:10:23 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:68.00 stddev:0.99 (1.5%) stddev-sans-first:0.97 09:10:23 INFO - PROCESS | 1674 | Values: 66.0 68.0 68.0 66.0 67.0 66.0 68.0 68.0 68.0 66.0 09:10:23 INFO - PROCESS | 1674 | -------- Summary: end -------- 09:10:23 INFO - PROCESS | 1674 | 09:10:24 INFO - TEST-INFO | 1674: exit 0 09:10:24 INFO - TEST-OK | kraken | took 57862ms 09:10:24 INFO - SUITE-END | took 1170s 09:10:24 INFO - Completed test suite (00:19:31) 09:10:24 INFO - javascript benchmark 09:10:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3290.9506357404634, 3573.731970102243, 3580.0154957386717, 3591.4792355108502, 3648.543932008499, 5776.075827867542, 5791.884162316762, 5803.129530570416, 5812.651240925547, 5828.446297601727, 5765.942340576593, 5827.096799995997, 5833.358330583633, 5837.562182836283, 5837.766489340422, 5236.874072074504, 5252.52727254548, 5260.0, 5295.338082739658, 5342.626016178869, 5309.787608495655, 5370.3287089113865, 5381.81163659272, 5385.649932754359, 5399.595030372738, 5269.947300526984, 5310.15037593985, 5311.123664595337, 5323.0152421801895, 5362.892742145154, 5320.494553017457, 5369.865753356158, 5372.409035006146, 5383.0, 5408.486193811621, 5114.641975061747, 5178.741062946875, 5240.528352448298, 5278.47215278473, 5290.153575427951, 5569.192467092249, 5569.637973531708, 5578.581606379537, 5588.944110558883, 5644.294463192101, 6288.151099601541, 6290.591111577733, 6302.621842689453, 6317.178766760338, 6322.178116844827, 6182.227221597301, 6188.566800323979, 6259.0, 6263.530235232331, 6285.591436556655, 5896.882062358729, 5905.084711869667, 5905.379935106838, 5910.172575839386, 5923.229980102602, 6292.244930608264, 6312.084747711648, 6322.4942004639515, 6330.873382532415, 6334.873302533923, 5139.8458046258675, 6104.481119104837, 6198.411150940653, 6212.0, 6212.1303017577575, 6198.876022479615, 6250.593711408744, 6265.65538895356, 6288.025356069817, 6309.211348581427, 6188.721507532172, 6258.0, 6263.592866463665, 6265.96867015662, 6285.088662143963, 6106.066326226518, 6256.937430625727, 6287.968560157261, 6291.465225455796, 6296.244450665858, 4939.259111133359, 4963.6277279204205, 5000.1749711297225, 5011.523905228997, 5027.974860125676, 4028.154087641628, 4285.849995250152, 4452.554744525586, 4500.2799552072165, 4505.43682039745, 5836.503897168788, 5974.103884417372, 5996.2504686914135, 6008.969955150196, 6050.667213303311, 6157.568970172135, 6221.2845522764555, 6236.719347629368, 6237.937620623827, 6243.656598887105, 5982.0, 5982.162497250389, 5984.744962607819, 5988.401159883977, 6048.0, 5374.435684253097, 5456.972715136479, 5460.235567020621, 5471.616986810965, 5531.529819965348, 6322.841928951721, 6379.075034120119, 6410.8717825643225, 6426.1003459515705, 6434.0, 6240.344763799917, 6244.094606282155, 6249.312575616769, 6257.56197066201, 6268.404501572343, 6253.968730156502, 6348.93651063502, 6408.198975128109, 6428.035794630843, 6444.323346048597, 6173.69131543412, 6267.185265915584, 6275.5920865145445, 6287.717052732546, 6291.0, 6175.536834737502, 6234.064890266496, 6245.750169993149, 6251.374862513712, 6253.843653908689, 5676.460736230051, 6079.452849243589, 6095.146679464967, 6135.233095863017, 6201.937980620317, 6178.907316390168, 6204.81385558434, 6205.441510264098, 6218.06728990655, 6224.751009959732, 6011.90982135277, 6117.357677443804, 6118.418750218722, 6130.0, 6144.109104179958, 6016.699165041818, 6045.244344456943, 6242.094896240111, 6248.9062664059165, 6255.186825712628, 6063.393660633901, 6084.087386892002, 6086.684010764503, 6104.938950610437, 6136.846578835565], "value": 5776.56598390127, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [533.9561157936236, 544.5779520871326, 575.9625624334416, 577.0910815465642, 639.1914228500947, 32610.347793044155, 33353.66646333536, 33449.66550334496, 33522.66477335226, 33569.83215083927, 34692.0, 35137.472937905884, 35172.824135879346, 35995.0, 41190.794046029805, 9784.217262618991, 9926.751831204241, 9930.65242716505, 9946.90053099467, 9983.450910199936, 9691.903080969207, 9832.557534910946, 9833.704988850346, 9839.606415743361, 9848.261380396463, 9279.350445468819, 12048.216865903732, 12316.0, 12320.95271901885, 12337.568185113523, 12007.639770806889, 12076.758464830698, 12142.939285303517, 12173.330466824322, 12178.0, 11803.468843902045, 11899.88100119005, 11921.225120367148, 11926.165168438212, 11943.34311612861, 40192.59807401918, 40623.39064914029, 40631.593684063075, 40639.79680101581, 40646.796766016276, 3294.3081952789944, 3343.966560334414, 3431.4852772084137, 3692.7599706019023, 4038.454808600831, 28969.85515072411, 29810.701892981226, 30072.8496357519, 30226.0, 30462.69537304621, 2760.144355249879, 2779.3607470281745, 2792.0786140573564, 2795.1335086123163, 2816.8169069010655, 498134.0, 504761.4285785716, 505330.0, 509580.4520977371, 514825.0, 52482.21276680853, 62691.373086268555, 62712.0, 63301.050484242776, 63443.0, 73352.63323683347, 74445.62777186079, 74616.62691686615, 74707.62646186844, 74755.0, 17549.912250438665, 18647.347342842935, 18672.81327186738, 18674.253029878924, 18682.719759203625, 14128.788068178985, 14177.716445671029, 14191.858081419261, 14195.64510887236, 14212.857871421153, 18669.066546672613, 20392.796072039386, 20541.79458205399, 20691.482712931997, 21200.575988480145, 8165.95917020423, 8270.627821748036, 8281.917180828115, 8341.789425802168, 8394.45436046655, 977.1254727019278, 1022.2486472442748, 1131.1007748839527, 1150.442035612744, 1171.4084387384316, 30231.395372092436, 30710.078697639106, 30937.535936960965, 31095.911643092382, 31667.84166079155, 1184.3841202574786, 1188.9227200231958, 1198.0595232742255, 1215.7143071378218, 1268.4165283969294, 14489.492867749577, 15424.845751542565, 16042.197890105448, 16282.94160879539, 16300.918495407446, 619965.0, 628728.0, 630189.8490507518, 630689.0, 631064.0, 63490.36509634937, 65164.0, 65472.0, 65480.34519654838, 65559.34440655628, 1454.5999850041323, 1479.408236705305, 1503.8796896248273, 1573.3077445923757, 1596.7844341014047, 25257.621135682613, 32759.017229483154, 33264.83367583147, 33545.49681754727, 34132.82933585316, 59469.0, 59947.0, 59948.0, 59970.901018464145, 60305.69847150912, 390753.0, 402548.0, 403010.0, 415362.0, 415364.0, 25297.62053569235, 28720.42559148847, 28769.85615071911, 29207.41585168242, 29326.853365733034, 44579.77710111429, 45561.29684912173, 45564.54435455603, 46332.7683361581, 46902.76548617235, 36790.0, 36802.26395472129, 37143.071423214635, 37171.62828371682, 39681.0, 38461.423078653286, 38709.612903871726, 38730.8380748578, 39316.213675725754, 39808.80095599504, 38285.6171438282, 38896.6110338893, 38922.0, 38964.80517597394, 39410.0, 33845.98462046142, 33858.15354616154, 34746.9575912723, 34771.0, 34913.0, 25666.871665641553, 25912.61131083073, 25952.610710838973, 26035.349116271485, 26429.7357026435], "value": 20801.284439155857, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.209202515221, 416.35672885392074, 419.572036522747, 421.8207261913688, 430.9159713855797, 21004.68492972605, 21328.81464375331, 21580.244691435804, 21721.153701935335, 22261.888690556563, 18141.0, 21268.361949141512, 21498.785012149874, 21806.45483862904, 21808.8909555452, 5716.22830917827, 5874.5006674432725, 5879.588428809985, 6139.416755408251, 6155.01519756839, 4335.978320108395, 4706.341112244271, 5744.368119506851, 6056.152138700585, 6182.72177752, 6140.662263575501, 6822.7612033578835, 6835.58986460814, 6837.418819400357, 6862.313768623148, 6553.868922621545, 6808.0, 6844.076049733272, 6851.897221541681, 6863.176418829722, 4050.574689657573, 5607.579431542651, 6021.09683547467, 6028.156058151862, 6050.425209605124, 26413.867930660224, 27002.5949610756, 27273.863630681917, 27746.02888898899, 27781.305467363276, 2355.093289083698, 2376.6910301660673, 2436.4152603375064, 2543.1988923489225, 2802.4395120975682, 14901.478448254258, 15019.849801501954, 15117.244137793066, 15713.978591391522, 16046.679066418606, 1772.5745821002995, 1776.404904357042, 1822.6719190545696, 1862.0317434933893, 1864.6643604151247, 104614.47692761563, 107337.46331268371, 108714.0, 109958.45020774845, 112340.0, 11253.943730281297, 11479.13906457019, 11660.00889924366, 11669.416529173677, 11785.233959792586, 14563.490277840225, 14631.707365852624, 14658.047226930428, 14698.41206351734, 14703.55889323322, 7232.457565682595, 9289.628414863464, 9292.0, 9393.62425502986, 9410.341276110606, 9254.583543740548, 9262.397944133745, 9296.349255552183, 9349.766255843659, 9355.906440935503, 4007.238624661305, 4119.752814831119, 4785.306130611042, 4900.240462728283, 4903.485134060944, 1752.3954235788633, 1806.4667980817353, 1954.853385996056, 1994.9501262468264, 2068.3588087692865, 893.2853717026353, 959.4531117263093, 965.1217392173089, 971.8396464583265, 1100.5432745410565, 16321.0, 20712.792872071088, 21035.78964210369, 21072.367828965154, 21357.359279221648, 915.4598786715869, 1000.2498126405196, 1006.7785087280787, 1073.1951036722458, 1078.660222030058, 7975.84048319042, 9731.318807683536, 11504.309741415542, 11541.422928853692, 11600.187986841009, 624726.0, 638369.0, 638983.0, 652576.0, 654932.0, 127498.0, 134922.0, 135970.0, 141601.0, 142405.0, 1006.4866917871792, 1022.7085280694967, 1025.3950169400089, 1026.6868605075374, 1071.1002757683427, 18562.628747425246, 18893.71659425082, 19117.13972871196, 19121.0, 19405.611887762447, 55695.72152139214, 56005.15992260201, 57000.0, 57624.0, 58640.0, 81321.0, 83232.0, 84408.57795711228, 84936.30127397295, 87544.5622771882, 8550.700725474579, 8580.742577722678, 8582.184692454206, 8649.956750216208, 8803.647854085764, 9487.288453365887, 12409.131360804657, 13249.602511924657, 13618.591442256748, 13737.450501979809, 11382.54469821231, 11723.472443740222, 11731.0, 11862.051035917279, 12068.275903445821, 9923.454210018519, 9928.305018648625, 11500.424978750862, 11512.59705910289, 11770.999465045566, 11815.586454474053, 11918.0, 11981.64055078349, 12058.698532536757, 12200.389980500762, 7456.7390141344795, 8349.707760228363, 8456.95771521163, 8465.576721163794, 9104.408213466104, 10189.184865210616, 11778.587749428729, 11785.351805650429, 11877.643670689893, 11940.940295298815], "value": 10022.610290861387, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1485.2351039214814, 1624.204139971414, 1654.495378909433, 1964.0965156028226, 2062.2060506704915, 8304.0, 8956.552172391379, 9136.360454768168, 9152.222061124812, 9157.31320150988, 8791.384603077788, 9071.72784816455, 9103.04418036105, 9105.772355691095, 9114.088591140882, 2525.3686578355455, 2549.757773011561, 2557.9360515987064, 2560.334313078604, 2560.9231723048247, 2499.662545556354, 2564.948701025978, 2572.4469239113682, 2575.459153577751, 2576.2013775729583, 2530.8101892358054, 2556.412025234188, 2563.141347648531, 2575.343287461704, 2577.8066645001604, 2529.6837895263093, 2556.7059788124325, 2571.7428257174133, 2572.3954870605394, 2573.7426257374204, 2343.238447504568, 2386.3556839653197, 2388.9163879264315, 2388.9522209555885, 2391.868447235401, 8836.983746869128, 9063.09369063095, 9150.816983660356, 9218.81562368749, 9222.492762898039, 5541.251930989345, 5676.148577713376, 5746.109353050242, 5764.538836893039, 5766.682832444214, 3595.1551385424405, 3672.008557689409, 3746.9063273418383, 3757.812109394519, 3764.5858955514873, 1036.9014943580348, 1042.888028061011, 1061.601899287767, 1069.9304545204614, 1097.358045543358, 12187.451564679523, 12447.3776311185, 12448.564300249447, 12466.563670271587, 12471.501139954391, 4693.577578017995, 4769.475357710649, 4788.377510923558, 4826.927596086061, 4850.733209673432, 8113.5131892086665, 9644.228461723045, 9651.131398174057, 9658.034196580285, 9659.71020869375, 5474.507294343528, 5501.119820828648, 5519.116941289455, 5529.060059789846, 5549.38956714761, 4561.087782443525, 4681.81272749093, 4684.508126646653, 4708.246680531167, 5140.074786538385, 3502.649735026477, 3675.5589329280656, 3955.149642826806, 4036.65688416482, 4066.9186616267507, 1236.8515778106505, 1244.7012716947868, 1248.4257241668752, 1256.4408838067154, 1261.8864302212844, 862.3403096631082, 908.5003248213588, 937.8921424036323, 989.6536212325628, 1039.0233180810014, 6023.216981792339, 6122.479589234876, 6209.534284928648, 6216.036514340284, 6257.687115644199, 950.2777888804559, 992.6476100984191, 997.546116516983, 1035.7203555040096, 1049.3651340938623, 4050.25070361984, 4121.29937910556, 4139.9793001035405, 4167.458230430025, 4202.222588821078, 10908.836367454494, 11356.659300221007, 11428.714282142846, 11455.656330310105, 11457.656270311903, 11170.944145279384, 11179.4969226385, 11188.944055279835, 11199.776004479865, 11272.380019098864, 7282.96358518204, 8156.592170391456, 8451.45065570736, 8528.317734581218, 8545.102764209792, 5903.734331955158, 6032.306284777307, 6040.607360521728, 6192.783252586138, 6212.192414986023, 9873.753156171153, 9881.604735810488, 10059.39643621385, 10062.69811905644, 10063.345882517613, 9694.079062489052, 10219.795604087727, 10244.538995745359, 10345.0, 10398.636047738293, 6818.522703410912, 7734.574598397142, 7764.34003109742, 7872.212778722082, 7888.092869320101, 7584.734534291273, 8605.096464871349, 8617.48295102296, 8623.741287761377, 8627.0, 7426.554406735613, 7462.253774622494, 7593.278638529331, 7742.225777422213, 7753.418493612889, 7479.439042071976, 7513.849723005618, 7571.0, 7571.848563028819, 7592.696292148473, 7194.820129496805, 7262.709491620276, 7274.272572742683, 7296.051513303237, 7369.705211791468, 4963.9575689105695, 5046.268291097696, 5069.340985671986, 5084.796608135781, 5137.897242055213, 4385.144896745104, 4960.107180707508, 5051.823186188466, 5159.716215608028, 5289.973550132225], "value": 4742.549458645453, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.74787161757064, 337.0848147280134, 341.92135808763976, 346.27628256942984, 349.067988470783, 5497.752601132948, 6551.017347397887, 6588.538802283836, 6600.933990660098, 6652.2349929757975, 5460.7440288733615, 6548.836279093025, 6566.080748695186, 6611.338866113386, 6631.171103612049, 4089.407035979781, 4713.363695901044, 4767.451743049559, 4928.5564299213065, 4998.350214472113, 4885.853424397274, 4945.035718034985, 4954.777035033414, 4972.279019542164, 4973.502649735034, 4881.560659540658, 4889.119958407486, 4911.287863259825, 4915.115279249733, 4923.236898280772, 4661.88345291367, 4728.054389122172, 4914.189158788796, 4917.655764096515, 4924.089043526923, 3561.857525698969, 4188.267053265667, 4201.1807697499, 4226.175895700339, 4249.320108782611, 6224.253089629228, 6226.25284965807, 6240.31356550779, 6264.0, 6266.4360207581085, 5774.740136693859, 5781.566382521328, 5798.507126894219, 5798.884022319572, 5826.009578371687, 6746.190457145125, 7009.1589009319205, 7021.61381124038, 7033.331833475811, 7038.085048943656, 4097.508299004138, 4641.630718937921, 4748.430188377417, 4760.571548560646, 4765.0, 7395.926040739578, 7443.8883416748795, 7448.0, 7458.067741532309, 7464.850702985964, 4833.347498087784, 4846.491118432585, 4855.344528488608, 4861.854144375674, 4865.829695960624, 4924.75376231187, 4925.064237794808, 4935.654504184673, 4935.876603084952, 4936.0, 4884.4871288514905, 5565.886822635489, 5830.3586605473365, 5833.300003999547, 5844.357120716718, 6692.196936367667, 7076.540024898468, 7083.079199704005, 7111.53775004623, 7116.146062472537, 1669.7996240451223, 1705.2326453096157, 1709.9572510687083, 1711.9486415407557, 1716.7081596128687, 1033.788073444942, 1046.2519298701466, 1083.3391631105019, 1086.9782604347868, 1110.9777804443866, 6596.472282217411, 6649.035889795952, 6669.233038200572, 6694.698738556776, 6709.865802683919, 7363.631818409165, 7373.29953654402, 7380.335769780745, 7408.777736667908, 7510.699572017167, 6804.387605115563, 6815.659217039129, 6821.590704557742, 6828.283030281848, 6834.863302733917, 3761.078535758702, 3857.1707082977296, 3905.179912218466, 3915.5888631693833, 3919.353306704362, 7829.295363417206, 7866.842663146705, 7872.606369681493, 7880.3301719354495, 7895.881561776578, 7566.659500322498, 7636.69453221876, 7640.465167438337, 7651.311381975537, 7676.385889128856, 7258.927410725931, 7790.922090779133, 7821.178776228414, 7821.335186509211, 7829.177936316719, 7070.222275549582, 7403.14863790671, 7419.109706835215, 7432.030511914239, 7443.218462061405, 7257.237990011184, 7282.817929551804, 7305.452091093083, 7338.96330518344, 7344.816379590339, 7809.609519523888, 7814.140444551209, 7831.843363132592, 7858.5677787722225, 7877.409194310335, 4653.46485154198, 4704.035672687022, 4706.717596944194, 4717.764111794328, 4725.243960966229, 7028.929710702828, 7331.486795924234, 7387.482876198615, 7393.519421237817, 7405.925940740523, 7095.893561596684, 7136.964315178391, 7137.250588688321, 7143.571385716874, 7167.921302822123, 7124.358807707331, 7137.714491420285, 7148.213696493485, 7152.9270609409, 7162.570245785061, 7010.123734533184, 7016.649167541705, 7020.473464490286, 7022.473314501535, 7036.9296307036275, 6827.283135270725, 7127.2516385778745, 7133.108361454818, 7139.643017848983, 7153.570785752663, 5620.269364982526, 6695.263521012782, 6805.1833779944745, 6916.827079323057, 6991.2659170788365], "value": 5217.939062236816, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.6467448612938, 723.6562632749444, 745.6197339356933, 765.1850778920449, 816.9468984516004, 15411.614709632266, 15693.764593531077, 15748.685026299467, 15803.130827804465, 15804.60488487787, 14539.273036348193, 14610.0, 14623.976321657488, 14625.488107916199, 14628.853711462882, 768.7885831396355, 780.3016300411128, 845.8096928191154, 935.8315503209419, 961.7932144588912, 942.6889126588244, 943.259541260111, 952.3999880075543, 953.980920381592, 956.2636769687336, 1009.9141572966307, 1017.0236572889997, 1018.9643362482315, 1020.2959957629212, 1021.3310281765456, 807.0557447786105, 817.4114637461018, 818.4475479051616, 820.3560205238919, 1007.7531004903772, 748.0350348051007, 752.5108679358406, 764.6711913877031, 765.0742601452249, 765.544501021891, 15214.239288035664, 15247.0, 15270.31283592241, 15271.38914443421, 15335.386584536605, 12847.164934279243, 12993.155444896052, 13223.33883305831, 13290.401931913088, 13320.800187997187, 10159.796804063952, 10197.694069177936, 10198.184145268435, 10237.64168254115, 10709.839352409721, 3568.37553428149, 3575.3564358415474, 3604.4052731299566, 3661.761985470936, 3832.1760821423527, 76244.61877690631, 76344.61827690882, 77779.83330250051, 77927.0, 78361.99999999943, 9535.427874327563, 9629.0, 9643.421394716339, 9718.611255549698, 10066.396016238903, 22062.33812985613, 22966.425839353815, 22977.965991530422, 23044.423889402562, 23131.7277549733, 7663.655135518915, 7667.693292268247, 7684.807879802938, 7712.8457430852195, 7766.262205090507, 4219.409282700424, 4251.234777739975, 4270.12462445198, 4371.0, 4432.113577284492, 3817.8091095445116, 3863.1887303666545, 3866.4007078902814, 3867.1105645701646, 3867.16855875988, 639.0956796133512, 665.6505334699225, 666.9166354205724, 671.2247354305784, 671.3890359772583, 557.7768892443055, 608.2305883057935, 617.2500411999442, 620.3331418724889, 633.7274971762095, 7573.35626471745, 8386.245237928615, 8507.872381914276, 8573.056963733985, 8593.52735599548, 517.5057819782099, 548.775002249084, 607.1954660075418, 610.914471973924, 632.8512799492115, 3719.237556300952, 3817.408301713239, 3830.7701537907815, 3929.096307849211, 4054.0, 95147.57278640688, 95526.0, 95911.04088959021, 96719.0, 97010.0, 80414.0, 80830.19169808227, 81833.9541511467, 81921.18078819136, 83486.58256708678, 67452.0, 73744.0, 73822.2617773826, 74526.62736686281, 75877.0, 8460.196281353261, 8542.530160841214, 8655.394122411371, 8676.479411235094, 8721.302295816193, 48331.275030875266, 51207.23189152091, 51777.0, 52320.0, 53231.41070187729, 55444.0, 70501.58996819932, 72791.0, 73815.261847383, 75090.0, 11218.326900386002, 11344.376059316817, 11524.769504609692, 11761.647150585497, 11823.349715765371, 12005.519779208735, 12089.57686480969, 12259.218904627382, 12312.630621081023, 12890.226586404846, 11596.844558656427, 11686.649400517997, 11850.822237666614, 11872.703182420508, 11898.183704206147, 11454.656360309204, 11873.762524749283, 11898.497835865313, 11935.104867135173, 12024.639260822189, 11485.425728713699, 11697.122715796178, 11834.0, 12023.75952480963, 12086.274823510617, 9889.55497002651, 10055.798884022131, 10128.59485620567, 10168.33905796121, 10423.374597524173, 9698.806023879624, 9935.533934220806, 9953.701388958343, 10009.697391650123, 10051.346662466916], "value": 7119.662297546434, "unit": "score"}], "name": "dromaeo_css", "value": 7723.096561594968, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 119.0, 113.0, 113.0, 111.0, 114.0, 114.0, 113.0, 135.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 139.0, 170.0, 165.0, 118.0, 139.0, 140.0, 117.0, 168.0, 120.0], "value": 143.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 196.0, 257.0, 204.0, 186.0, 184.0, 186.0, 186.0, 184.0], "value": 195.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 77.0, 75.0, 152.0, 56.0, 55.0, 57.0, 62.0, 127.0, 56.0], "value": 78.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 90.0, 142.0, 80.0, 82.0, 96.0, 126.0, 80.0, 78.0, 125.0], "value": 98.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 90.0, 87.0, 93.0, 126.0, 122.0, 87.0, 91.0, 86.0], "value": 95.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 96.0, 94.0, 94.0, 94.0, 93.0, 93.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 98.0, 135.0, 126.0, 84.0, 84.0, 83.0, 85.0, 87.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 77.0, 59.0, 56.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 74.0, 75.0, 71.0, 66.0, 66.0, 66.0, 66.0], "value": 67.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 80.0, 78.0, 79.0, 79.0, 77.0, 79.0, 79.0, 98.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 127.0, 127.0, 127.0, 125.0, 127.0, 125.0, 123.0, 145.0, 138.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 164.0, 166.0, 167.0, 166.0, 163.0, 161.0, 168.0, 166.0], "value": 165.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 68.0, 66.0, 67.0, 66.0, 68.0, 68.0, 68.0, 66.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1489.9, "alertThreshold": 2.0}]} 09:10:24 INFO - Return code: 0 09:10:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:10:25 ERROR - # TBPL SUCCESS # 09:10:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:10:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:10:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:10:25 INFO - 2016-07-26 09:10:25.054 screenresolution[1678:9715] starting screenresolution argv=screenresolution get 09:10:25 INFO - 2016-07-26 09:10:25.057 screenresolution[1678:9715] Display 0: 1600x1200x32@60 09:10:25 INFO - 2016-07-26 09:10:25.063 screenresolution[1679:9718] starting screenresolution argv=screenresolution list 09:10:25 INFO - Available Modes on Display 0 09:10:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:10:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:10:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:10:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:10:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:10:25 INFO - Intel Iris: 09:10:25 INFO - Chipset Model: Intel Iris 09:10:25 INFO - Type: GPU 09:10:25 INFO - Bus: Built-In 09:10:25 INFO - VRAM (Dynamic, Max): 1536 MB 09:10:25 INFO - Vendor: Intel (0x8086) 09:10:25 INFO - Device ID: 0x0a2e 09:10:25 INFO - Revision ID: 0x0009 09:10:25 INFO - Displays: 09:10:25 INFO - Display: 09:10:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:10:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:10:25 INFO - Display Serial Number: 1600x1200 60 09:10:25 INFO - Main Display: Yes 09:10:25 INFO - Mirror: Off 09:10:25 INFO - Online: Yes 09:10:25 INFO - Rotation: Supported 09:10:25 INFO - Return code: 0 09:10:25 INFO - Running post-action listener: _resource_record_post_action 09:10:25 INFO - Running post-run listener: _resource_record_post_run 09:10:26 INFO - Total resource usage - Wall time: 1195s; CPU: 52.0%; Read bytes: 37955072; Write bytes: 492651520; Read time: 374; Write time: 1541 09:10:26 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 191275520; Write bytes: 184668160; Read time: 17628; Write time: 364 09:10:26 INFO - run-tests - Wall time: 1173s; CPU: 52.0%; Read bytes: 31862784; Write bytes: 297194496; Read time: 300; Write time: 1144 09:10:26 INFO - Running post-run listener: _upload_blobber_files 09:10:26 INFO - Blob upload gear active. 09:10:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:10:26 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 09:10:26 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'] 09:10:26 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 09:10:26 INFO - (blobuploader) - INFO - Open directory for files ... 09:10:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:10:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:10:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:10:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:10:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:10:27 INFO - (blobuploader) - INFO - Done attempting. 09:10:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:10:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:10:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:10:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:10:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:10:28 INFO - (blobuploader) - INFO - Done attempting. 09:10:28 INFO - (blobuploader) - INFO - Iteration through files over. 09:10:28 INFO - Return code: 0 09:10:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:10:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:10:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6cf0438aa97943e52b7c3b63614937327c0974e8ece6ccefda9c9a3436bf80a587d4a46251b883aace6ccebbf89178382dafa55b052bc543b91850cf4122633e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c74f443ca4215c5e4747d868ccb5069e8b244a2c675b840a802b0cf918aff963a71ddf76bc28df36c77cc6b5fbcc10e6e855bf137b6295a90cb327a7c0cb80c4"} 09:10:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:10:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:10:28 INFO - Contents: 09:10:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6cf0438aa97943e52b7c3b63614937327c0974e8ece6ccefda9c9a3436bf80a587d4a46251b883aace6ccebbf89178382dafa55b052bc543b91850cf4122633e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c74f443ca4215c5e4747d868ccb5069e8b244a2c675b840a802b0cf918aff963a71ddf76bc28df36c77cc6b5fbcc10e6e855bf137b6295a90cb327a7c0cb80c4"} 09:10:28 INFO - Running post-run listener: copy_logs_to_upload_dir 09:10:28 INFO - Copying logs to upload dir... 09:10:28 INFO - mkdir: /builds/slave/test/build/upload/logs 09:10:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.940898 ========= master_lag: 2.64 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-07-26 09:10:31.472555) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 09:10:31.476471) ========= 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.CTFaoSkxjX/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.UdLVHZadaP/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6cf0438aa97943e52b7c3b63614937327c0974e8ece6ccefda9c9a3436bf80a587d4a46251b883aace6ccebbf89178382dafa55b052bc543b91850cf4122633e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c74f443ca4215c5e4747d868ccb5069e8b244a2c675b840a802b0cf918aff963a71ddf76bc28df36c77cc6b5fbcc10e6e855bf137b6295a90cb327a7c0cb80c4"} build_url:https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010745 build_url: 'https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6cf0438aa97943e52b7c3b63614937327c0974e8ece6ccefda9c9a3436bf80a587d4a46251b883aace6ccebbf89178382dafa55b052bc543b91850cf4122633e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c74f443ca4215c5e4747d868ccb5069e8b244a2c675b840a802b0cf918aff963a71ddf76bc28df36c77cc6b5fbcc10e6e855bf137b6295a90cb327a7c0cb80c4"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 09:10:31.517033) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 09:10:31.517791) ========= 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.CTFaoSkxjX/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.UdLVHZadaP/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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.005323 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 09:10:31.570214) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 09:10:31.570915) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 09:10:31.571640) ========= ========= Total master_lag: 2.78 =========