builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0083 starttime: 1461081102.68 results: success (0) buildid: 20160419071033 builduid: 9fe06245d54648769791125562980d93 revision: c07c7171bcc979c24398fa9c0389a82dff425f10 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 08:51:42.683530) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 08:51:42.683967) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 08:51:42.684256) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 08:51:42.703741) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 08:51:42.704043) ========= 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.u2ZiVl2QcF/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.82xR3U8KW3/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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-04-19 08:51:42-- 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% 37.6M=0s 2016-04-19 08:51:42 (37.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113281 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 08:51:42.834599) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 08:51:42.834919) ========= 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.u2ZiVl2QcF/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.82xR3U8KW3/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.026718 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 08:51:42.883769) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 08:51:42.884120) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c07c7171bcc979c24398fa9c0389a82dff425f10 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c07c7171bcc979c24398fa9c0389a82dff425f10 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.u2ZiVl2QcF/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.82xR3U8KW3/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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-04-19 08:51:42,959 truncating revision to first 12 chars 2016-04-19 08:51:42,959 Setting DEBUG logging. 2016-04-19 08:51:42,959 attempt 1/10 2016-04-19 08:51:42,959 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c07c7171bcc9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 08:51:43,313 unpacking tar archive at: mozilla-aurora-c07c7171bcc9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.605381 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 08:51:43.506273) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 08:51:43.506622) ========= script_repo_revision: c07c7171bcc979c24398fa9c0389a82dff425f10 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 08:51:43.507019) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 08:51:43.507282) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 08:51:43.519424) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-19 08:51:43.519729) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.u2ZiVl2QcF/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.82xR3U8KW3/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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:51:43 INFO - MultiFileLogger online at 20160419 08:51:43 in /builds/slave/test 08:51:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:51:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:51:43 INFO - {'append_to_log': False, 08:51:43 INFO - 'base_work_dir': '/builds/slave/test', 08:51:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:51:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:51:43 INFO - 'branch': 'Mozilla-Aurora', 08:51:43 INFO - 'buildbot_json_path': 'buildprops.json', 08:51:43 INFO - 'config_files': ('talos/mac_config.py',), 08:51:43 INFO - 'default_actions': ('clobber', 08:51:43 INFO - 'read-buildbot-config', 08:51:43 INFO - 'download-and-extract', 08:51:43 INFO - 'populate-webroot', 08:51:43 INFO - 'create-virtualenv', 08:51:43 INFO - 'install', 08:51:43 INFO - 'run-tests'), 08:51:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:51:43 INFO - 'download_minidump_stackwalk': True, 08:51:43 INFO - 'download_symbols': 'ondemand', 08:51:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:51:43 INFO - 'tooltool.py': '/tools/tooltool.py', 08:51:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:51:43 INFO - '/tools/misc-python/virtualenv.py')}, 08:51:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:51:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:51:43 INFO - 'installer_path': 'installer.exe', 08:51:43 INFO - 'log_level': 'info', 08:51:43 INFO - 'log_name': 'talos', 08:51:43 INFO - 'log_to_console': True, 08:51:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:51:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:51:43 INFO - 'opt_config_files': (), 08:51:43 INFO - 'pip_index': False, 08:51:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:51:43 INFO - 'cmd': ('bash', 08:51:43 INFO - '-c', 08:51:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:51:43 INFO - 'enabled': True, 08:51:43 INFO - 'halt_on_failure': False, 08:51:43 INFO - 'name': 'check_screen_resolution'},), 08:51:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:51:43 INFO - 'cmd': ('bash', 08:51:43 INFO - '-c', 08:51:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:51:43 INFO - 'enabled': True, 08:51:43 INFO - 'halt_on_failure': False, 08:51:43 INFO - 'name': 'check_screen_resolution'},), 08:51:43 INFO - 'run_cmd_checks_enabled': True, 08:51:43 INFO - 'sps_profile': False, 08:51:43 INFO - 'sps_profile_interval': 0, 08:51:43 INFO - 'suite': 'dromaeojs-e10s', 08:51:43 INFO - 'system_bits': '32', 08:51:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:51:43 INFO - 'title': 't-yosemite-r7-0083', 08:51:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:51:43 INFO - 'use_talos_json': True, 08:51:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:51:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:51:43 INFO - 'work_dir': 'build'} 08:51:43 INFO - ##### 08:51:43 INFO - ##### Running clobber step. 08:51:43 INFO - ##### 08:51:43 INFO - Running pre-action listener: _resource_record_pre_action 08:51:43 INFO - Running main action method: clobber 08:51:43 INFO - rmtree: /builds/slave/test/build 08:51:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:51:45 INFO - Running post-action listener: _resource_record_post_action 08:51:45 INFO - ##### 08:51:45 INFO - ##### Running read-buildbot-config step. 08:51:45 INFO - ##### 08:51:45 INFO - Running pre-action listener: _resource_record_pre_action 08:51:45 INFO - Running main action method: read_buildbot_config 08:51:45 INFO - Using buildbot properties: 08:51:45 INFO - { 08:51:45 INFO - "project": "", 08:51:45 INFO - "product": "firefox", 08:51:45 INFO - "script_repo_revision": "production", 08:51:45 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 08:51:45 INFO - "repository": "", 08:51:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 08:51:45 INFO - "buildid": "20160419071033", 08:51:45 INFO - "pgo_build": "False", 08:51:45 INFO - "basedir": "/builds/slave/test", 08:51:45 INFO - "buildnumber": 279, 08:51:45 INFO - "slavename": "t-yosemite-r7-0083", 08:51:45 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:51:45 INFO - "platform": "yosemite_r7", 08:51:45 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:51:45 INFO - "branch": "mozilla-aurora", 08:51:45 INFO - "repo_path": "releases/mozilla-aurora", 08:51:45 INFO - "revision": "c07c7171bcc979c24398fa9c0389a82dff425f10", 08:51:45 INFO - "stage_platform": "macosx64", 08:51:45 INFO - "builduid": "9fe06245d54648769791125562980d93", 08:51:45 INFO - "slavebuilddir": "test" 08:51:45 INFO - } 08:51:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 08:51:45 INFO - Running post-action listener: _resource_record_post_action 08:51:45 INFO - ##### 08:51:45 INFO - ##### Running download-and-extract step. 08:51:45 INFO - ##### 08:51:45 INFO - Running pre-action listener: _resource_record_pre_action 08:51:45 INFO - Running main action method: download_and_extract 08:51:45 INFO - mkdir: /builds/slave/test/build/tests 08:51: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:51:45 INFO - https://queue.taskcluster.net/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:51:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 08:51:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 08:51:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 08:51:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 08:51:47 INFO - Downloaded 1277 bytes. 08:51:47 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 08:51:47 INFO - Using the following test package requirements: 08:51:47 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 08:51:47 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:51:47 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 08:51:47 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:51:47 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 08:51:47 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:51:47 INFO - u'jsshell-mac.zip'], 08:51:47 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:51:47 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 08:51:47 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 08:51:47 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:51:47 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 08:51:47 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:51:47 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 08:51:47 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:51:47 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 08:51:47 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 08:51:47 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:51:47 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 08:51:47 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:51:47 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:51:47 INFO - https://queue.taskcluster.net/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:51:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 08:51:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 08:51:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 08:51:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:51:49 INFO - Downloaded 17911386 bytes. 08:51:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:51:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:51:52 INFO - Return code: 0 08:51:52 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:51: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:51:52 INFO - https://queue.taskcluster.net/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:51:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 08:51:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 08:51:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 08:51:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:51:54 INFO - Downloaded 17911386 bytes. 08:51:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:51:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:51:57 INFO - Return code: 0 08:51: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:51:57 INFO - https://queue.taskcluster.net/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:51:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 08:51:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 08:51:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 08:51:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:51:58 INFO - Downloaded 10845168 bytes. 08:51:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:51:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 08:51:59 INFO - Return code: 0 08:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:59 INFO - https://queue.taskcluster.net/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 08:51:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 08:51:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 08:51:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 08:51:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 08:52:05 INFO - Downloaded 115250120 bytes. 08:52:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 08:52:05 INFO - mkdir: /builds/slave/test/properties 08:52:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:52:05 INFO - Writing to file /builds/slave/test/properties/build_url 08:52:05 INFO - Contents: 08:52:05 INFO - build_url:https://queue.taskcluster.net/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 08:52:07 INFO - Running post-action listener: _resource_record_post_action 08:52:07 INFO - Running post-action listener: set_extra_try_arguments 08:52:07 INFO - ##### 08:52:07 INFO - ##### Running populate-webroot step. 08:52:07 INFO - ##### 08:52:07 INFO - Running pre-action listener: _resource_record_pre_action 08:52:07 INFO - Running main action method: populate_webroot 08:52:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:52:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:52:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:52:07 INFO - '--tppagecycles', 08:52:07 INFO - '7'], 08:52:07 INFO - 'tests': ['tsvgm']}}, 08:52:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:52:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:52:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:52:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:52:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:52:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:52:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:52:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:07 INFO - 'talos_options': ['--e10s'], 08:52:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:52:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:07 INFO - 'tests': ['damp', 'tps']}, 08:52:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:07 INFO - 'talos_options': ['--e10s'], 08:52:07 INFO - 'tests': ['damp', 'tps']}, 08:52:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:52:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:52:07 INFO - 'other': {'tests': ['a11yr', 08:52:07 INFO - 'ts_paint', 08:52:07 INFO - 'tpaint', 08:52:07 INFO - 'sessionrestore', 08:52:07 INFO - 'sessionrestore_no_auto_restore', 08:52:07 INFO - 'tabpaint']}, 08:52:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:52:07 INFO - 'tests': ['a11yr', 08:52:07 INFO - 'ts_paint', 08:52:07 INFO - 'tpaint', 08:52:07 INFO - 'sessionrestore', 08:52:07 INFO - 'sessionrestore_no_auto_restore', 08:52:07 INFO - 'tabpaint']}, 08:52:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:52:07 INFO - 'tests': ['a11yr', 08:52:07 INFO - 'ts_paint', 08:52:07 INFO - 'tpaint', 08:52:07 INFO - 'sessionrestore', 08:52:07 INFO - 'sessionrestore_no_auto_restore', 08:52:07 INFO - 'tabpaint']}, 08:52:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:52:07 INFO - 'tests': ['a11yr', 08:52:07 INFO - 'ts_paint', 08:52:07 INFO - 'tpaint', 08:52:07 INFO - 'sessionrestore', 08:52:07 INFO - 'sessionrestore_no_auto_restore', 08:52:07 INFO - 'tabpaint']}, 08:52:07 INFO - 'other_l64': {'tests': ['a11yr', 08:52:07 INFO - 'ts_paint', 08:52:07 INFO - 'tpaint', 08:52:07 INFO - 'sessionrestore', 08:52:07 INFO - 'sessionrestore_no_auto_restore', 08:52:07 INFO - 'tabpaint']}, 08:52:07 INFO - 'other_nol64': {'tests': ['a11yr', 08:52:07 INFO - 'ts_paint', 08:52:07 INFO - 'tpaint', 08:52:07 INFO - 'sessionrestore', 08:52:07 INFO - 'sessionrestore_no_auto_restore', 08:52:07 INFO - 'tabpaint']}, 08:52:07 INFO - 'svgr': {'tests': ['tsvgx', 08:52:07 INFO - 'tsvgr_opacity', 08:52:07 INFO - 'tart', 08:52:07 INFO - 'tscrollx', 08:52:07 INFO - 'cart']}, 08:52:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:52:07 INFO - 'tests': ['tsvgx', 08:52:07 INFO - 'tsvgr_opacity', 08:52:07 INFO - 'tart', 08:52:07 INFO - 'tscrollx', 08:52:07 INFO - 'cart']}, 08:52:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:07 INFO - 'tests': ['tp5o']}, 08:52:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:07 INFO - 'talos_options': ['--e10s'], 08:52:07 INFO - 'tests': ['tp5o']}, 08:52:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:07 INFO - 'talos_options': ['--xperf_path', 08:52:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:52:07 INFO - 'tests': ['tp5n']}, 08:52:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:52:07 INFO - 'talos_options': ['--e10s', 08:52:07 INFO - '--xperf_path', 08:52:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:52:07 INFO - 'tests': ['tp5n']}}, 08:52:07 INFO - 'talos.zip': {'path': '', 08:52:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:52:07 INFO - Running post-action listener: _resource_record_post_action 08:52:07 INFO - ##### 08:52:07 INFO - ##### Running create-virtualenv step. 08:52:07 INFO - ##### 08:52:07 INFO - Running pre-action listener: _resource_record_pre_action 08:52:07 INFO - Running main action method: create_virtualenv 08:52:07 INFO - Creating virtualenv /builds/slave/test/build/venv 08:52:07 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:52:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:52:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:52:07 INFO - Using real prefix '/tools/python27' 08:52:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:52:08 INFO - Installing distribute.............................................................................................................................................................................................done. 08:52:10 INFO - Installing pip.................done. 08:52:10 INFO - Return code: 0 08:52:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:52: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:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52: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:52:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e837a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e83e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccb85c9970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6dbd30>, '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 0x10e53fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d2b20>, '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.u2ZiVl2QcF/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.82xR3U8KW3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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:52:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:52:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:52:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u2ZiVl2QcF/Render', 08:52:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:10 INFO - 'HOME': '/Users/cltbld', 08:52:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:10 INFO - 'LOGNAME': 'cltbld', 08:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:10 INFO - 'MOZ_NO_REMOTE': '1', 08:52:10 INFO - 'NO_EM_RESTART': '1', 08:52:10 INFO - 'PAGER': '/bin/cat', 08:52:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:10 INFO - 'PWD': '/builds/slave/test', 08:52:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:10 INFO - 'SHELL': '/bin/bash', 08:52:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.82xR3U8KW3/Listeners', 08:52:10 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 08:52:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:10 INFO - 'USER': 'cltbld', 08:52:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:10 INFO - 'XPC_FLAGS': '0x0', 08:52:10 INFO - 'XPC_SERVICE_NAME': '0', 08:52:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:11 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:52:11 INFO - Cleaning up... 08:52:11 INFO - Return code: 0 08:52:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:52:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e837a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e83e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccb85c9970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6dbd30>, '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 0x10e53fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d2b20>, '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.u2ZiVl2QcF/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.82xR3U8KW3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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:52:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:52:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:52:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u2ZiVl2QcF/Render', 08:52:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:11 INFO - 'HOME': '/Users/cltbld', 08:52:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:11 INFO - 'LOGNAME': 'cltbld', 08:52:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:11 INFO - 'MOZ_NO_REMOTE': '1', 08:52:11 INFO - 'NO_EM_RESTART': '1', 08:52:11 INFO - 'PAGER': '/bin/cat', 08:52:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:11 INFO - 'PWD': '/builds/slave/test', 08:52:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:11 INFO - 'SHELL': '/bin/bash', 08:52:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.82xR3U8KW3/Listeners', 08:52:11 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 08:52:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:11 INFO - 'USER': 'cltbld', 08:52:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:11 INFO - 'XPC_FLAGS': '0x0', 08:52:11 INFO - 'XPC_SERVICE_NAME': '0', 08:52:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:11 INFO - Downloading/unpacking psutil>=0.7.1 08:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:52:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:52:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:52:14 INFO - Installing collected packages: psutil 08:52:14 INFO - Running setup.py install for psutil 08:52:14 INFO - building 'psutil._psutil_osx' extension 08:52:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:52:15 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:52:15 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:52:15 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:52:15 INFO - building 'psutil._psutil_posix' extension 08:52:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:52:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:52:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:52:15 INFO - ^ 08:52:15 INFO - 1 warning generated. 08:52:15 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:52:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:52:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:52:15 INFO - Successfully installed psutil 08:52:15 INFO - Cleaning up... 08:52:15 INFO - Return code: 0 08:52:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:52: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:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52: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:52:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e837a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e83e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccb85c9970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6dbd30>, '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 0x10e53fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d2b20>, '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.u2ZiVl2QcF/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.82xR3U8KW3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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:52:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:52:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:52:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u2ZiVl2QcF/Render', 08:52:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:15 INFO - 'HOME': '/Users/cltbld', 08:52:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:15 INFO - 'LOGNAME': 'cltbld', 08:52:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:15 INFO - 'MOZ_NO_REMOTE': '1', 08:52:15 INFO - 'NO_EM_RESTART': '1', 08:52:15 INFO - 'PAGER': '/bin/cat', 08:52:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:15 INFO - 'PWD': '/builds/slave/test', 08:52:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:15 INFO - 'SHELL': '/bin/bash', 08:52:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.82xR3U8KW3/Listeners', 08:52:15 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 08:52:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:15 INFO - 'USER': 'cltbld', 08:52:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:15 INFO - 'XPC_FLAGS': '0x0', 08:52:15 INFO - 'XPC_SERVICE_NAME': '0', 08:52:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:52:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:52:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:52:18 INFO - Installing collected packages: mozsystemmonitor 08:52:18 INFO - Running setup.py install for mozsystemmonitor 08:52:18 INFO - Successfully installed mozsystemmonitor 08:52:18 INFO - Cleaning up... 08:52:18 INFO - Return code: 0 08:52:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:52: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:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52: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:52:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e837a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e83e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccb85c9970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6dbd30>, '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 0x10e53fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d2b20>, '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.u2ZiVl2QcF/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.82xR3U8KW3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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:52:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:52:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:52:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u2ZiVl2QcF/Render', 08:52:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:18 INFO - 'HOME': '/Users/cltbld', 08:52:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:18 INFO - 'LOGNAME': 'cltbld', 08:52:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:18 INFO - 'MOZ_NO_REMOTE': '1', 08:52:18 INFO - 'NO_EM_RESTART': '1', 08:52:18 INFO - 'PAGER': '/bin/cat', 08:52:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:18 INFO - 'PWD': '/builds/slave/test', 08:52:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:18 INFO - 'SHELL': '/bin/bash', 08:52:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.82xR3U8KW3/Listeners', 08:52:18 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 08:52:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:18 INFO - 'USER': 'cltbld', 08:52:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:18 INFO - 'XPC_FLAGS': '0x0', 08:52:18 INFO - 'XPC_SERVICE_NAME': '0', 08:52:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:18 INFO - Downloading/unpacking blobuploader==1.2.4 08:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:21 INFO - Downloading blobuploader-1.2.4.tar.gz 08:52:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:52:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:52: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:52: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:52: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:52: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:52: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:52: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:52:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:52:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:52: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:52: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:52: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:52: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:52: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:52: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:52:22 INFO - Downloading docopt-0.6.1.tar.gz 08:52:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:52:22 INFO - Installing collected packages: blobuploader, requests, docopt 08:52:22 INFO - Running setup.py install for blobuploader 08:52:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:52:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:52:22 INFO - Running setup.py install for requests 08:52:23 INFO - Running setup.py install for docopt 08:52:23 INFO - Successfully installed blobuploader requests docopt 08:52:23 INFO - Cleaning up... 08:52:23 INFO - Return code: 0 08:52:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e837a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e83e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccb85c9970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6dbd30>, '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 0x10e53fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d2b20>, '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.u2ZiVl2QcF/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.82xR3U8KW3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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:52:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:52:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:52:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u2ZiVl2QcF/Render', 08:52:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:23 INFO - 'HOME': '/Users/cltbld', 08:52:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:23 INFO - 'LOGNAME': 'cltbld', 08:52:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:23 INFO - 'MOZ_NO_REMOTE': '1', 08:52:23 INFO - 'NO_EM_RESTART': '1', 08:52:23 INFO - 'PAGER': '/bin/cat', 08:52:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:23 INFO - 'PWD': '/builds/slave/test', 08:52:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:23 INFO - 'SHELL': '/bin/bash', 08:52:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.82xR3U8KW3/Listeners', 08:52:23 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 08:52:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:23 INFO - 'USER': 'cltbld', 08:52:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:23 INFO - 'XPC_FLAGS': '0x0', 08:52:23 INFO - 'XPC_SERVICE_NAME': '0', 08:52:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:52:23 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-HJlSKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:52:23 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-cviEnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:52:23 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-LEniK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:52:23 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-3Ncq7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:52:24 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-bAmzqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:52:24 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-wsvd9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:52:24 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-uioMXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:52:24 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Azlxxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:52:24 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-UwVMzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:52:24 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-wEaCKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:52:24 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-ODZvQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:52:24 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-ulgs4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:52:24 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-jTi3RS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:52:24 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-QawbsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:25 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-1uoaJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:52:25 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-ZaW5IE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:52:25 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-CUZ5Iv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:52:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:52:25 INFO - Running setup.py install for manifestparser 08:52:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:52:25 INFO - Running setup.py install for mozcrash 08:52:25 INFO - Running setup.py install for mozdebug 08:52:25 INFO - Running setup.py install for mozdevice 08:52:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:52:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:52:25 INFO - Running setup.py install for mozfile 08:52:26 INFO - Running setup.py install for mozhttpd 08:52:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:52:26 INFO - Running setup.py install for mozinfo 08:52:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:52:26 INFO - Running setup.py install for mozInstall 08:52:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:52:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:52:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:52:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:52:26 INFO - Running setup.py install for mozleak 08:52:26 INFO - Running setup.py install for mozlog 08:52:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:52:26 INFO - Running setup.py install for moznetwork 08:52:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:52:26 INFO - Running setup.py install for mozprocess 08:52:27 INFO - Running setup.py install for mozprofile 08:52:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:52:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:52:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:52:27 INFO - Running setup.py install for mozrunner 08:52:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:52:27 INFO - Running setup.py install for mozscreenshot 08:52:27 INFO - Running setup.py install for moztest 08:52:27 INFO - Running setup.py install for mozversion 08:52:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:52:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:52:27 INFO - Cleaning up... 08:52:27 INFO - Return code: 0 08:52:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e837a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e83e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccb85c9970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6dbd30>, '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 0x10e53fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d2b20>, '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.u2ZiVl2QcF/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.82xR3U8KW3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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:52:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:52:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:52:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u2ZiVl2QcF/Render', 08:52:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:27 INFO - 'HOME': '/Users/cltbld', 08:52:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:27 INFO - 'LOGNAME': 'cltbld', 08:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:27 INFO - 'MOZ_NO_REMOTE': '1', 08:52:27 INFO - 'NO_EM_RESTART': '1', 08:52:27 INFO - 'PAGER': '/bin/cat', 08:52:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:27 INFO - 'PWD': '/builds/slave/test', 08:52:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:27 INFO - 'SHELL': '/bin/bash', 08:52:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.82xR3U8KW3/Listeners', 08:52:27 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 08:52:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:27 INFO - 'USER': 'cltbld', 08:52:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:27 INFO - 'XPC_FLAGS': '0x0', 08:52:27 INFO - 'XPC_SERVICE_NAME': '0', 08:52:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:52:28 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-aRX3Uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:52:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:52:28 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-M0N9DO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:52:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:52:28 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Skjd7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:52:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:52:28 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-W0hAQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:52:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:52:28 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-hCExzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:52:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:52:28 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-R401OO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:52:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:52:28 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-2DtCvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:52:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:52:28 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-9BMHAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:52:29 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-LkR9lY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:52:29 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-IAfpvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:52:29 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-JocZ8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:52:29 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-v3dm71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:52:29 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-ca5Htb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:52:29 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-C9VEHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:29 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-yX1Kso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:52:29 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-YPJhCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:52:29 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-pbpFqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:52:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:32 INFO - Downloading blessings-1.6.tar.gz 08:52:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:52:32 INFO - Installing collected packages: blessings 08:52:32 INFO - Running setup.py install for blessings 08:52:32 INFO - Successfully installed blessings 08:52:32 INFO - Cleaning up... 08:52:32 INFO - Return code: 0 08:52:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:52:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:52:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:52:33 INFO - Reading from file tmpfile_stdout 08:52:33 INFO - Current package versions: 08:52:33 INFO - blessings == 1.6 08:52:33 INFO - blobuploader == 1.2.4 08:52:33 INFO - docopt == 0.6.1 08:52:33 INFO - manifestparser == 1.1 08:52:33 INFO - mozInstall == 1.12 08:52:33 INFO - mozcrash == 0.17 08:52:33 INFO - mozdebug == 0.1 08:52:33 INFO - mozdevice == 0.48 08:52:33 INFO - mozfile == 1.2 08:52:33 INFO - mozhttpd == 0.7 08:52:33 INFO - mozinfo == 0.9 08:52:33 INFO - mozleak == 0.1 08:52:33 INFO - mozlog == 3.1 08:52:33 INFO - moznetwork == 0.27 08:52:33 INFO - mozprocess == 0.22 08:52:33 INFO - mozprofile == 0.28 08:52:33 INFO - mozrunner == 6.11 08:52:33 INFO - mozscreenshot == 0.1 08:52:33 INFO - mozsystemmonitor == 0.0 08:52:33 INFO - moztest == 0.7 08:52:33 INFO - mozversion == 1.4 08:52:33 INFO - psutil == 3.1.1 08:52:33 INFO - requests == 1.2.3 08:52:33 INFO - wsgiref == 0.1.2 08:52:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:33 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 0x10e837a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e83e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccb85c9970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6dbd30>, '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 0x10e53fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d2b20>, '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.u2ZiVl2QcF/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.82xR3U8KW3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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:52:33 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:52:33 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:52:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u2ZiVl2QcF/Render', 08:52:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:33 INFO - 'HOME': '/Users/cltbld', 08:52:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:33 INFO - 'LOGNAME': 'cltbld', 08:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:33 INFO - 'MOZ_NO_REMOTE': '1', 08:52:33 INFO - 'NO_EM_RESTART': '1', 08:52:33 INFO - 'PAGER': '/bin/cat', 08:52:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:33 INFO - 'PWD': '/builds/slave/test', 08:52:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:33 INFO - 'SHELL': '/bin/bash', 08:52:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.82xR3U8KW3/Listeners', 08:52:33 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 08:52:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:33 INFO - 'USER': 'cltbld', 08:52:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:33 INFO - 'XPC_FLAGS': '0x0', 08:52:33 INFO - 'XPC_SERVICE_NAME': '0', 08:52:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:52:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:52:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:52:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:52:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:52:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:52:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:52:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:52:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:52:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:52:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:52:33 INFO - Cleaning up... 08:52:33 INFO - Return code: 0 08:52:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e837a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e83e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccb85c9970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6dbd30>, '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 0x10e53fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d2b20>, '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.u2ZiVl2QcF/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.82xR3U8KW3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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:52:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:52:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:52:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u2ZiVl2QcF/Render', 08:52:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:33 INFO - 'HOME': '/Users/cltbld', 08:52:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:33 INFO - 'LOGNAME': 'cltbld', 08:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:33 INFO - 'MOZ_NO_REMOTE': '1', 08:52:33 INFO - 'NO_EM_RESTART': '1', 08:52:33 INFO - 'PAGER': '/bin/cat', 08:52:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:33 INFO - 'PWD': '/builds/slave/test', 08:52:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:33 INFO - 'SHELL': '/bin/bash', 08:52:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.82xR3U8KW3/Listeners', 08:52:33 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 08:52:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:33 INFO - 'USER': 'cltbld', 08:52:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:33 INFO - 'XPC_FLAGS': '0x0', 08:52:33 INFO - 'XPC_SERVICE_NAME': '0', 08:52:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:33 INFO - Downloading/unpacking jsonschema 08:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:52:36 INFO - Downloading/unpacking functools32 (from jsonschema) 08:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:36 INFO - Downloading functools32-3.2.3-2.tar.gz 08:52:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:52:36 INFO - warning: no files found matching '*.txt' 08:52:36 INFO - no previously-included directories found matching 'build' 08:52:36 INFO - no previously-included directories found matching 'dist' 08:52:36 INFO - no previously-included directories found matching '.git*' 08:52:36 INFO - Installing collected packages: jsonschema, functools32 08:52:36 INFO - Running setup.py install for functools32 08:52:36 INFO - warning: no files found matching '*.txt' 08:52:36 INFO - no previously-included directories found matching 'build' 08:52:36 INFO - no previously-included directories found matching 'dist' 08:52:36 INFO - no previously-included directories found matching '.git*' 08:52:36 INFO - Successfully installed jsonschema functools32 08:52:36 INFO - Cleaning up... 08:52:36 INFO - Return code: 0 08:52:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:52: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:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52: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:52:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e837a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e83e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccb85c9970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6dbd30>, '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 0x10e53fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d2b20>, '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.u2ZiVl2QcF/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.82xR3U8KW3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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:52:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:52:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:52:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u2ZiVl2QcF/Render', 08:52:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:52:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:52:36 INFO - 'HOME': '/Users/cltbld', 08:52:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:52:36 INFO - 'LOGNAME': 'cltbld', 08:52:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:36 INFO - 'MOZ_NO_REMOTE': '1', 08:52:36 INFO - 'NO_EM_RESTART': '1', 08:52:36 INFO - 'PAGER': '/bin/cat', 08:52:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:52:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:36 INFO - 'PWD': '/builds/slave/test', 08:52:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:52:36 INFO - 'SHELL': '/bin/bash', 08:52:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.82xR3U8KW3/Listeners', 08:52:36 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 08:52:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:52:36 INFO - 'USER': 'cltbld', 08:52:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:52:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:52:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:36 INFO - 'XPC_FLAGS': '0x0', 08:52:36 INFO - 'XPC_SERVICE_NAME': '0', 08:52:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:52:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:37 INFO - Downloading/unpacking flake8 08:52:37 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:52:37 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:52:37 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:52:37 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:52:37 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:52:37 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:52:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:52:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:52:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:52:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:52:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:52:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:52:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:52:41 INFO - no previously-included directories found matching 'docs/_build' 08:52:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:52:41 INFO - Running setup.py install for pep8 08:52:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:52:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:52:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:52:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:52:41 INFO - no previously-included directories found matching 'docs/_build' 08:52:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:52:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:52:41 INFO - Cleaning up... 08:52:41 INFO - Return code: 0 08:52:41 INFO - Running post-action listener: _resource_record_post_action 08:52:41 INFO - Running post-action listener: _start_resource_monitoring 08:52:41 INFO - Starting resource monitoring. 08:52:41 INFO - ##### 08:52:41 INFO - ##### Running install step. 08:52:41 INFO - ##### 08:52:41 INFO - Running pre-action listener: _resource_record_pre_action 08:52:41 INFO - Running main action method: install 08:52:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:52:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:52:41 INFO - Reading from file tmpfile_stdout 08:52:41 INFO - Detecting whether we're running mozinstall >=1.0... 08:52:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:52:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:52:41 INFO - Reading from file tmpfile_stdout 08:52:41 INFO - Output received: 08:52:41 INFO - Usage: mozinstall [options] installer 08:52:41 INFO - Options: 08:52:41 INFO - -h, --help show this help message and exit 08:52:41 INFO - -d DEST, --destination=DEST 08:52:41 INFO - Directory to install application into. [default: 08:52:41 INFO - "/builds/slave/test"] 08:52:41 INFO - --app=APP Application being installed. [default: firefox] 08:52:41 INFO - mkdir: /builds/slave/test/build/application 08:52:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:52:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:53:13 INFO - Reading from file tmpfile_stdout 08:53:13 INFO - Output received: 08:53:13 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:53:13 INFO - Running post-action listener: _resource_record_post_action 08:53:13 INFO - ##### 08:53:13 INFO - ##### Running run-tests step. 08:53:13 INFO - ##### 08:53:13 INFO - Running pre-action listener: _resource_record_pre_action 08:53:13 INFO - Running main action method: run_tests 08:53:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:53:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:53:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:53:13 INFO - 2016-04-19 08:53:13.970 screenresolution[1631:7499] starting screenresolution argv=screenresolution get 08:53:13 INFO - 2016-04-19 08:53:13.973 screenresolution[1631:7499] Display 0: 1600x1200x32@60 08:53:13 INFO - 2016-04-19 08:53:13.979 screenresolution[1632:7501] starting screenresolution argv=screenresolution list 08:53:13 INFO - Available Modes on Display 0 08:53:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:53:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:53:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:53:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:53:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:53:14 INFO - Intel Iris: 08:53:14 INFO - Chipset Model: Intel Iris 08:53:14 INFO - Type: GPU 08:53:14 INFO - Bus: Built-In 08:53:14 INFO - VRAM (Dynamic, Max): 1536 MB 08:53:14 INFO - Vendor: Intel (0x8086) 08:53:14 INFO - Device ID: 0x0a2e 08:53:14 INFO - Revision ID: 0x0009 08:53:14 INFO - Displays: 08:53:14 INFO - Display: 08:53:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:53:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:53:14 INFO - Display Serial Number: 1600x1200 60 08:53:14 INFO - Main Display: Yes 08:53:14 INFO - Mirror: Off 08:53:14 INFO - Online: Yes 08:53:14 INFO - Rotation: Supported 08:53:14 INFO - Return code: 0 08:53:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:53:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:53:14 INFO - Python 2.7.3 08:53:14 INFO - Return code: 0 08:53:14 INFO - grabbing minidump binary from tooltool 08:53: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:53:14 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 0x10e6dbd30>, '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 0x10e53fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:53:14 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:53:14 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:53:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:53:14 INFO - Return code: 0 08:53:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:53:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:53:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:53:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:53:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:53:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:53:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:53:15 INFO - Return code: 0 08:53:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0083', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:53:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0083 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:53:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u2ZiVl2QcF/Render', 08:53:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:15 INFO - 'HOME': '/Users/cltbld', 08:53:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:15 INFO - 'LOGNAME': 'cltbld', 08:53:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:53:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:53:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:15 INFO - 'MOZ_NO_REMOTE': '1', 08:53:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:53:15 INFO - 'NO_EM_RESTART': '1', 08:53:15 INFO - 'PAGER': '/bin/cat', 08:53:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:15 INFO - 'PWD': '/builds/slave/test', 08:53:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:53:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:15 INFO - 'SHELL': '/bin/bash', 08:53:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.82xR3U8KW3/Listeners', 08:53:15 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 08:53:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:15 INFO - 'USER': 'cltbld', 08:53:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:15 INFO - 'XPC_FLAGS': '0x0', 08:53:15 INFO - 'XPC_SERVICE_NAME': '0', 08:53:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0083', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:53:15 INFO - mozversion application_buildid: 20160419071033 08:53:15 INFO - mozversion application_changeset: c07c7171bcc979c24398fa9c0389a82dff425f10 08:53:15 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:53:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:53:15 INFO - mozversion application_name: Firefox 08:53:15 INFO - mozversion application_remotingname: firefox-dev 08:53:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:53:15 INFO - mozversion application_vendor: Mozilla 08:53:15 INFO - mozversion application_version: 47.0a2 08:53:15 INFO - mozversion platform_buildid: 20160419071033 08:53:15 INFO - mozversion platform_changeset: c07c7171bcc979c24398fa9c0389a82dff425f10 08:53:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:53:15 INFO - mozversion platform_version: 47.0a2 08:53:15 INFO - using testdate: 1461081195 08:53:15 INFO - actual date: 1461081195 08:53:15 INFO - starting webserver on 'localhost:49269' 08:53:15 INFO - SUITE-START | Running 2 tests 08:53:15 INFO - TEST-START | dromaeo_css 08:53:15 INFO - operating with platform_type : mac_ 08:53:15 INFO - Initialising browser for dromaeo_css test... 08:53:15 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpBt6MQh/profile http://localhost:49269/getInfo.html) 08:53:18 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 08:53:18 INFO - PROCESS | 1650 | colorDepth:24 08:53:18 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 08:53:18 INFO - PROCESS | 1650 | __metrics 08:53:18 ERROR - PROCESS | 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 08:53:19 INFO - TEST-INFO | 1650: exit 0 08:53:19 INFO - Browser initialized. 08:53:19 INFO - Running cycle 1/1 for dromaeo_css test... 08:53:19 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpBt6MQh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:53:31 INFO - PROCESS | 1653 | RSS: Main: 217853952 08:53:31 INFO - PROCESS | 1653 | 08:54:20 INFO - PROCESS | 1653 | 1461081260797 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:56:31 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 08:56:32 INFO - PROCESS | 1653 | RSS: Main: 228757504 08:56:32 INFO - PROCESS | 1653 | 08:59:34 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 08:59:35 INFO - PROCESS | 1653 | RSS: Main: 240463872 08:59:35 INFO - PROCESS | 1653 | 09:02:37 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 09:02:37 INFO - PROCESS | 1653 | RSS: Main: 242642944 09:02:37 INFO - PROCESS | 1653 | 09:05:39 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 09:05:39 INFO - PROCESS | 1653 | RSS: Main: 244092928 09:05:39 INFO - PROCESS | 1653 | 09:08:42 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 09:08:43 INFO - PROCESS | 1653 | RSS: Main: 247463936 09:08:43 INFO - PROCESS | 1653 | 09:11:45 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 09:11:45 INFO - PROCESS | 1653 | RSS: Main: 248381440 09:11:45 INFO - PROCESS | 1653 | 09:11:45 INFO - PROCESS | 1653 | __start_tp_report 09:11:45 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 09:11:45 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 09:11:45 INFO - PROCESS | 1653 | |i|pagename|runs| 09:11:45 INFO - PROCESS | 1653 | |0;dojo.html;2994.745446637036;3506.263684626229;3561.6972557332642;3615.6926661233792;3630.3102410541997;5842.386549412315;5852.795152169675;5858;5862.384449632791;5898.941010589893;5821.09772985188;5835.270591176103;5862.648241105526;5873.207117039198;5877.265341832271;5252.6848389096585;5289.127293996486;5334.1732031535175;5369.62412631116;5406.243125962349;5268.446813084628;5337.626366154371;5366.141417373221;5384.7846086156505;5407.297051383314;5280.287161233242;5340.67955922644;5371.650842695231;5378.596605254622;5424.783008679668;4197.958020419787;5407.297051383295;5408.296921400232;5414.83755487336;5423.078076726966;5258.868528286824;5305.336832895888;5311.203319502067;5332.573394128461;5360.571154307646;5635.633683810539;5643.68959707216;5647.519960803336;5701.315842098975;5733.426657334233;6209.813705588839;6262.2798378186635;6272.968635156795;6303.9684801575695;6306.369363063703;6335.936640633627;6340.112384266206;6344.3655634436645;6349.619022858597;6355.8411039723915;5809.390014048507;5955.821325360246;6019.668918209497;6028.065649824284;6086.604370715978;6386.10594516768;6435.324290949477;6436.388543088399;6439.581427207217;6458.773942911976;6242.937570624235;6266.530010249249;6271.278802937721;6283.622982621057;6292.402221788922;6204.193454850841;6248.062790581358;6279.215098112736;6320.778772743024;6328;6235.127082208494;6249;6288.874222515524;6296.65368404733;6316.30520642729;6180.845478863064;6281.089242059876;6285.685715714196;6294.779682711083;6332.303446620868;4946.530079642428;4979.551840334388;4986.052649996562;4986.476419975923;5020.297158397827;4458.598726114666;4468.597826195593;4498.482674492409;4503.864884053483;4508.368828364031;5752.626079304831;5860.062390017577;5893.057110862242;5894.056950887837;5897.439743224387;4823.975880120577;5221.843344699665;5573.108302671553;5776.682282474504;6341.207349081365;4955.2567114933045;5881.852953676107;5932.58471906971;5945.554083443759;5950.523958083343;5389.0299746046085;5399.757010934517;5471.452854714496;5490.368607610176;5524.392316845144;6286.277078135981;6453.774117905851;6466;6481;6489.123968264318;6263.906041409291;6295.842603934755;6300.842478938063;6302.684865756785;6302.9684851577285;5063.620228482952;5396.325459317585;6434.2922278548385;6497.707603157774;6528.608283503005;6011.909821352596;6267.4045965633195;6278.309385967448;6304.085907543472;6329.5252856036905;5067.189249720027;5719.48524632785;6283.183186185766;6295.213098362705;6303.2436107665535;6119.510439164945;6123.5876691309595;6227.1282020516255;6228.941080016318;6246.156768836149;6199.225096862892;6199.225096862892;6214.25428948529;6219.626822390671;6249.812505624838;5471.534919531884;6022.36765139654;6060.181875446759;6067.302260240129;6102.237220347457;6113.932424433873;6156.938430615636;6229.56393052482;6252.3122456530655;6255.468285195628;6041.969790151021;6117.969410153099;6124.234470691164;6130.693465326805;6151.96924015395 09:11:45 INFO - PROCESS | 1653 | |1;ext.html;572.4361503918642;579.9908159801946;639.2552676132306;676.7547712209533;679.5107522583739;38659.42010869836;39269.41095883564;39385.621503247356;39387.60612393875;39463.80268098663;40716.98207544805;41213.38179927303;41313.38029929546;41358.17283654325;41361.58638413615;9432.292578056638;9609.615615375376;9641.951790241039;9659.082387173243;9695.078967498112;8195.262426381625;8378.790530236762;9679.225661947063;9693.127618514332;9722.513874306293;9658.75853103671;9663.806723865519;9685.75785605362;9779.951100244525;9787.90212097877;8552;9633.325667203299;9675.225981921465;9685.41887486753;9749.36629119105;8372.748817535483;9721.611135554569;9766.755831104208;9794.167495762798;9811.411315321104;40374.59625403738;40402.191956161005;40685.79657101725;40732;40735.59264407348;3156.889508867179;3362.8822991195434;3827.158025234444;3866.8646597368956;3940.133170702441;28885.277868053257;29371;29437.705622943926;29459.558106628418;29507.70492295071;2601.388673661707;2640.7227241139594;2641.418887844671;2685.328667833042;2708.7832973362083;478703;496912;499027;501891;504295;48816.02367952621;49432.25851612229;71336.92994604982;71718.2828171722;71722.64138679273;47732.52267477281;48303.516964830604;48352.758236209294;48616.75691621519;48855.511444885095;16708.24812883423;16767;16929.915350423416;16995.150242487827;16997.745033824503;13317.600471985856;13405.396757145756;13418.993575481878;13475;13479.932600336935;15454.227288635524;15764.842351576566;15773.526794196192;15831.920840395724;15860.20698965047;5576.275084239104;5593.580481463825;5755.85610359736;6623.8077146114165;6639.701213445406;962.4081190068198;1033.4367769565604;1060.8726952765717;1115.341948250536;1145.7135716070982;30288.394232115676;30796;31206.84396578048;31245.843770781;31255.687443125276;1110.9500072496758;1147.3345459633392;1170.6546568762235;1210.8002179640437;1265.7088869560052;12733.808992865115;14754.893382996319;15236.619084522976;15800.683986320439;15826.683466330609;522955;524992;525460;528417;529323;62573.68713156496;64215.67892160603;64325.03512447317;64375.35624643787;64727.67636161789;1520.8707259882813;1522;1537.3927298716944;1544.6833399153147;1547.396515359011;29772.55341169841;30368;30704;30733.589198003745;30825;55450.05924792613;55516;56081.439185609255;56155.71922140363;56195.71902140463;505804;505856;507606;508949;509102;35405.11487212737;35789.642103579674;45940.8514787133;46660;47761.044779104916;44916.55083449124;45270.77364613156;45396.31905521486;45486.317705233785;45889;27611.861940690167;35606.465903010954;37401;37919.62080379271;37985.4302185473;37041.81479092587;37451.81274093612;37714.811425942695;38748.6125138745;39050.82044769824;34285.657143428245;38828.41757373698;39880.800595996836;40512.79743601263;40639.79680101581;25116.62325065089;31125.221869453446;33075.50386744249;33389.83305083459;33598;23583.29250122499;24366.512669746153;25397.87301063483;25461.981520738962;25532 09:11:45 INFO - PROCESS | 1653 | |2;jquery.html;369.1712106321309;375.8985074030012;377.74964866292555;379.4270651316512;381.1310212715011;17258.568535786595;20322.28871989481;20600.69098963513;21159.576808463822;21174.57650846982;21120.57758844822;21166.25918092867;21210.681839772376;21456.678149827763;21580.460488487795;5191.922121168185;5774.682392468402;6039.607425517349;6065.787697430591;6076.058210977306;4573.291139873309;5700.6579605223615;5751.217122691979;6154.876902461948;6156.045812899008;6103.664298463583;6118.174046503709;6131.47882429994;6146;6157.661328626924;5537.972310138443;5792.420757924216;5804.419558044183;5809.448102430262;5821.359650438449;5391.919121213145;5546.362168350611;5551.611387202897;5569.220309156722;5659.801906933238;13214.933925330408;13518.93240533791;13520.526781562598;13672.794908076386;14037.298135093306;2129.6273152198305;2246.2811900191946;2250.324902529251;2541.1741184115235;2606.7914566834606;10068.244881633907;10263.281570290083;10285.07268409499;13549.796753048711;13830.446782128703;1636.869050475959;1641.662903281838;1714.211462727147;1755.9297628094862;1767.9116044197867;100638.49680751623;107130;113037;113064;114056.85943140545;9827.606895724091;11138.665840024812;11237.21339506243;11396.974272315532;11476.598319058792;11712.941435292769;14085.43658253679;14139.85860141406;14278.42886284537;14342.49801256951;7342.118945726547;8664.35017373687;8990.685326013558;9041.654587802555;9119.863202051974;7902.565358905201;8032.59837008159;9157.496337701357;9268.073192680678;9299.395539289924;4164.333706606928;4434.82260709568;4551.704139230939;4554.63562914966;4582.991741816795;1567.3025503650765;1830.2770405689944;1869.7943226245102;1897.7343171955938;1921.9615607687767;896.9775755606162;969.6024629901707;1027.3681685763202;1047.0628787235382;1105.8949399807007;20617.278395256093;21160;21247.468813279793;21250.681239781417;21335.893320533298;981.8301553566697;997.3467378866853;1014.2595904989399;1024.8411496218098;1041.7551875309296;11093.00162985319;11505.367204803817;11563.42182890852;11564.90133437322;11599.362035088152;522797.3860130751;528215;529839;625615;678132;91863;128402.35798820946;130756;132277;137444;1076.2520048566328;1079.3254216114772;1079.7624522605172;1126.4536699700639;1126.487448211062;18056.020087758956;18768;18974.810251897303;19041.523961900508;19458;54208;54666.45333546614;54808.62978425412;55125;56160.157597636884;77525.61237193778;77748.22251777409;78180;78882.21117788748;78908.21091789239;7916.683332666629;8042.879356809535;8156.469829461066;8262.049864265686;8392.412531123007;13142.277174755098;13248.602541923758;13340.266285354399;13355.198688078746;13563.118397304144;9591.232701383733;11483.36841473727;11538.653840384803;11790.764184716429;12045.518179273082;9668.903310967082;9967.601295948081;11262.774744505228;11464.885351146715;11804.232724872856;11498.25261358009;11672.88327116718;11805.76388472243;12045.156839021534;12126.878731212575;7206.135263768381;8239.588020598827;8277.503349799032;8428.831423371375;8575.22822945913;9929.255305851946;11649.301041937511;11697.122715796178;11726.94136529312;12063.21589096706 09:11:45 INFO - PROCESS | 1653 | |3;mootools.html;1673.113249977512;1704.3864208884804;1756.490617720861;1766.816233123807;2094.57061302433;7971.485417770627;8134.918650813505;8847.646094156242;9019.323550733696;9270.258379329654;8892.555372231378;8926.2412694921;9027.14242146995;9040.593173307201;9060.093990600937;2537.9746202538017;2563.6026415905562;2574.253466494724;2581.90963316284;2592.62406950992;2511.6483692283095;2533.5439620868237;2535.1000394859834;2535.5816290312077;2546.567083595793;2524.7475252474787;2525.4065294655743;2534.4170840706647;2580.664513613237;2591.222633210039;2528.2415275417393;2545.8599777012255;2553.1957433408415;2566.615007748834;2571.742825717432;2524.5960646296503;2548.554003049459;2548.566743653583;2549.5665736824785;2570.0490818397125;9194.17252447283;9198.954005229998;9208.401453905542;9216.677416290464;9221;5707.71461426927;5753.654780713129;5774.82675519735;5856.502197313233;5891.234139561872;3576.6959808416054;3665.2669466106886;3669.321175582499;3731.328360895038;3739.420389839579;1032.4785983078573;1053.5469748008354;1056.4084112896803;1065.957361705531;1068.4657671164418;10418.322809017389;12367.62897113088;12428.62714118578;12436.440360183722;12469.937650311782;4986.601071914238;4998.050370429607;5117.616178786606;5122.948770512322;5134.948650513522;8885.689000885068;10548.156147508182;10563.419011954262;10579.259451838298;10607.257491975488;5641.492265696107;5702.515286200636;5750.827475175752;5762.538996880239;5762.567807414461;4650.186217412007;5030.597552195815;5134.691918484903;5160.767765450564;5170.767315470813;4092.4992411160842;4101.938470922939;4159.500859896832;4169.1661667666585;4198.1393814268;1253.348258905364;1347.7263985533773;1365.3514580574147;1392.4291040673274;1398.175076704749;1415.9362828672733;1440.942362305517;1454.4836583013089;1465.5823090419392;1477.4385733421232;8449.535275559903;8462.407631465861;8496.70261540843;8514.74455766328;8555.358348123791;517.6893863681836;522.4227228911998;523.3353640876066;532.1777853216789;532.5553163108771;6239.532035097295;6330.651814150266;6356.364363563699;6375.3624637536805;6387.233531976192;10918.399488028235;11175.21773475849;11183.83224251637;11227.494762735696;11285.830712539318;10694.572217111228;10987;11061.11511079128;11154.10767138627;11203.551857925591;7298.306660867209;8530.829383412298;8573;8700.521471319138;8736.388452808242;6892.793216203522;8034;8147.75556733299;8245.876311855207;8293.460925039853;8608.139186081342;9305.8367704037;9783.266255031043;9793.216542676711;9815.607375704893;9995.950020249853;10092.24308176875;10178.643747468803;10198.847017294895;10305.278630495794;7521.247875212435;7640.3505702015955;7686.385089192963;7763.417743669134;7800.1419843816;8500.192481714228;8562.143785621389;8571.657133714582;8574.09971952936;8582.527960962207;7432.814179645552;7617.352525035212;7631.580263085583;7718;7744.535327880345;6896.172459304916;7471.738489152854;7524.05949256343;7558.773236802905;7625.428092893166;7531.698732050657;8054.879176812469;8105;8114.229148230908;8151.959240203761;7097.574145551283;7286.781396558112;7302.379297759538;7307.159676637255;7354.96322518384;7302.598357090411;7315.049043624294;7332.96333518329;7337.3029562191505;7449 09:11:45 INFO - PROCESS | 1653 | |4;prototype.html;275.96826364968035;314.86146095717885;340.1004343511411;344.82586293921565;345.17847522895505;6255.468285195752;6524.890768569343;6843.315668433154;6941.09765730455;7028.894566581499;6877.724891004354;6882.277360877111;6886.001529778179;6897.551659142165;6924.134483189601;4036.757794532323;4752.619790416758;4882.56056954874;5015.523525265094;5035.647504674675;4936.925946110811;4971.801127954877;4979.28214765907;4979.327790748257;4987.202047672373;4923.483034281403;4999.600191907886;5005.47442518534;5008.524190201943;5030.320906677588;5008;5013;5015.523525265094;5020.949790502084;5026.396832380119;3544.946825797615;4271.765052922088;4282.164977829325;4295.441592592974;4298.032942587924;5385.623006389555;6642.368974947421;6692.46460283181;6741.0899528563505;6741.359570840762;4938.160512712848;5720.914186287209;5800.1299805029585;5859.209006784072;5894.911576326359;6002.8499287517725;7386.741464048732;7393.630318484054;7401.370883474858;7405.851882962311;4664.113818374498;4677.4854765975715;4677.812887484497;4689.953100468986;4694.859154225379;7341.669624866947;7703.8844417333785;7770.222977702241;7797.956583647661;7800.687972481151;4529.705569137996;4610.492845786961;4716.127516409407;4745.050989802054;4764.952350476451;4821.590164835958;4859.3682821233015;4860;4862.659613827069;4863.732494712754;4737.839229388822;5835.241418615553;5845.7201691340415;5860.2967643883;5869.090291004901;5266.894662106736;6377.5216858735785;6779.762708305186;6997.39060016189;7347.70609175627;1653.768472413863;1667.583104223944;1673.7740405045163;1679.8068222154363;1687.7130887749113;1011.7420057885192;1042.9374237545771;1044.511571011306;1061.6655753437642;1063.2716589136467;5872.207252021008;6717.496187785936;6811.727530898807;6837.282085381063;6925.272846351161;5357.276767636397;7113.039739635186;7113.253108423644;7614.695412183451;7642.656080476392;6764.255931847493;6776.288489708608;6785.355391237825;6796.286389929085;6820.147481564804;3927.7250592458827;4009.7393669411395;4038.6163314485075;4047.1500984793524;4050.210209009215;8046.557439340892;8048.315893149031;8069.475484093515;8071.9506464159285;8081.555514446762;7961.681532738741;8006.919930800734;8012.639431225609;8036.075851277178;8047.678092876219;8013.639386227517;8029.678812847537;8036.4374493786045;8058.435909486279;8070.717524886601;7396.6671499783715;7629.618519073913;7686.692532298645;7724.6910123594425;7756.650950707344;7522.5862577558755;7563.432742544442;7565.621718914143;7572.772816815284;7577.962110189414;8005.279524842559;8008.799780005546;8024.919750802417;8036.035675718951;8056.0735515414135;4693.835715749932;4748.572628463455;4749.430068391815;4756.524347565354;4782.426108866958;6633.2040155181685;7317.414606831334;7483.738069167771;7717.807054823675;7743.883841742491;6446.194225721785;7340.229275925951;7394.926050739424;7439.218882017527;7516.173220945801;6126.571140020156;7396.890466430079;7460.962695186489;7461.925380746123;7492.363149132385;6986.825329366807;7250.02124713157;7259.346658800733;7268.454865884974;7295.161056478573;7406.037215161994;7418.443616728875;7461.4403919705155;7472.252774722484;7483.401327893865;7190.89213661785;7236.348728614239;7241.348278654947;7260.128784545888;7269.836826107798 09:11:45 INFO - PROCESS | 1653 | |5;yui.html;660.2242365220865;676.6582875647797;774.7791879314397;803.710664160902;810.3274282345653;15203;15299.311530981106;15423.922880385582;15429.228538573083;15487.457938972138;14163.362648680808;14166;14197.929010354934;14226.502072427467;14241.430342786276;764.2701220334595;947.5688561704443;955.2930831184925;982.8378317577591;986.6102889358699;906.4244204929884;951.5242378810594;969.7478655549537;971.7910649210419;977.3647129365897;998.8901220865699;999.2705325112672;1040.4537617750705;1042.1766804224653;1047.2512153810023;1043.1341986151476;1044.0499145777344;1044.9216308776834;1046.1003536958285;1049.3861091261545;754.7433872483327;771.9922800771976;776.5418403142173;787.7321710618418;792.8771040488733;15083.622909427242;15156.090634561962;15346.616334591612;15428.228588570639;15549.455769048142;11144.442777861155;13126;13263.469461221635;13265.933670331586;13716;8252;10055.296129270953;10197.439140847251;10592.887746786553;10757.139428845674;3475.9652403475893;3537.7699005780105;3556.8043757593323;3567.2152126532123;3818.9045273868096;53532.464675353134;64939.99999999953;83945.32109357779;85827.14172858317;91446.54276728573;9670.468124253093;9934.304598678023;10008.299419040743;10072.697819065439;10094.848577271347;21624;22118.55762884733;22120.2257920972;23483.178088767152;24010.15964441236;6688.565243259172;7649.847003059907;7816;8065.717699880476;8099.635516401776;3938.6455219030427;4200.096979149497;4245.3844192591905;4303.289957157034;4498.370228168059;3721.14413684854;3725.0314918120944;3754.23038277158;3773.9433908491396;3774.150816066363;669.10340144207;677.6916502991127;682.0894106368054;689.6930865764687;693.1612748574181;525.3144646236698;607.3531688751466;616.7440512187482;624.5815303746501;628.0579131303045;8074.555899425471;8425.747227583182;8464.66141354339;8606.87089693655;8625.827483450295;548.4049805960577;611.1718621268118;614.1483427466193;630.8706715123388;633.9397757213058;3504.001359612498;3897.512810898638;3952.5849785772657;4015.257177422186;4076;67034;96321;96485.035149649;97841;100372;86346;86422;87068.56465717757;87965.56017219873;90579;30736.231594209876;30800.845995769876;74579;76186.85719714209;78780.81828772573;7249.166345870292;8514.233718965323;8810.383273170817;8908.643654253758;8931.883514560679;51041.46875593738;52398;53090.73454632702;53708.731456342466;53976.92046159133;69649.3035069663;72448;72764.63617681878;73433;75249.23753812397;11178.385188814693;11196;11272.154588405738;11415.543378264776;11653.359065251492;11977.442565759355;12098.93950530277;12148.39258037077;12229.510819567473;13053.477860885838;11309.830352544554;11734.178607497393;11876.465559050037;12088.972437342924;12274.895259426694;11540.307581545134;11914.821277680669;11957.760844782882;12134.211276267015;12278;11330.60342887995;11468.94265528667;11660.358680272666;11850.703732406759;11904;9648.565472053839;9764.707058788248;9923.305368624417;9931.851022234529;9960;9705.6117755289;10028.398296102258;10094.242931780293;10101.090901818578;10127.493625318852 09:11:45 INFO - PROCESS | 1653 | __end_tp_report 09:11:45 INFO - PROCESS | 1653 | __start_cc_report 09:11:45 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,360 09:11:45 INFO - PROCESS | 1653 | __end_cc_report 09:11:45 INFO - PROCESS | 1653 | __startTimestamp1461082305720__endTimestamp 09:11:45 INFO - PROCESS | 1653 | 09:11:45 INFO - PROCESS | 1653 | ------- Summary: start ------- 09:11:45 INFO - PROCESS | 1653 | Number of tests: 6 09:11:45 INFO - PROCESS | 1653 | 09:11:45 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5791.52 Median:6019.67 stddev:656.06 (10.9%) stddev-sans-first:620.30 09:11:45 INFO - PROCESS | 1653 | Values: 2994.7 3506.3 3561.7 3615.7 3630.3 5842.4 5852.8 5858.0 5862.4 5898.9 5821.1 5835.3 5862.6 5873.2 5877.3 5252.7 5289.1 5334.2 5369.6 5406.2 5268.4 5337.6 5366.1 5384.8 5407.3 5280.3 5340.7 5371.7 5378.6 5424.8 4198.0 5407.3 5408.3 5414.8 5423.1 5258.9 5305.3 5311.2 5332.6 5360.6 5635.6 5643.7 5647.5 5701.3 5733.4 6209.8 6262.3 6273.0 6304.0 6306.4 6335.9 6340.1 6344.4 6349.6 6355.8 5809.4 5955.8 6019.7 6028.1 6086.6 6386.1 6435.3 6436.4 6439.6 6458.8 6242.9 6266.5 6271.3 6283.6 6292.4 6204.2 6248.1 6279.2 6320.8 6328.0 6235.1 6249.0 6288.9 6296.7 6316.3 6180.8 6281.1 6285.7 6294.8 6332.3 4946.5 4979.6 4986.1 4986.5 5020.3 4458.6 4468.6 4498.5 4503.9 4508.4 5752.6 5860.1 5893.1 5894.1 5897.4 4824.0 5221.8 5573.1 5776.7 6341.2 4955.3 5881.9 5932.6 5945.6 5950.5 5389.0 5399.8 5471.5 5490.4 5524.4 6286.3 6453.8 6466.0 6481.0 6489.1 6263.9 6295.8 6300.8 6302.7 6303.0 5063.6 5396.3 6434.3 6497.7 6528.6 6011.9 6267.4 6278.3 6304.1 6329.5 5067.2 5719.5 6283.2 6295.2 6303.2 6119.5 6123.6 6227.1 6228.9 6246.2 6199.2 6199.2 6214.3 6219.6 6249.8 5471.5 6022.4 6060.2 6067.3 6102.2 6113.9 6156.9 6229.6 6252.3 6255.5 6042.0 6118.0 6124.2 6130.7 6152.0 09:11:45 INFO - PROCESS | 1653 | 09:11:45 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:65376.65 Median:40457.49 stddev:135699.30 (335.4%) stddev-sans-first:135992.74 09:11:45 INFO - PROCESS | 1653 | Values: 572.4 580.0 639.3 676.8 679.5 38659.4 39269.4 39385.6 39387.6 39463.8 40717.0 41213.4 41313.4 41358.2 41361.6 9432.3 9609.6 9642.0 9659.1 9695.1 8195.3 8378.8 9679.2 9693.1 9722.5 9658.8 9663.8 9685.8 9780.0 9787.9 8552.0 9633.3 9675.2 9685.4 9749.4 8372.7 9721.6 9766.8 9794.2 9811.4 40374.6 40402.2 40685.8 40732.0 40735.6 3156.9 3362.9 3827.2 3866.9 3940.1 28885.3 29371.0 29437.7 29459.6 29507.7 2601.4 2640.7 2641.4 2685.3 2708.8 478703.0 496912.0 499027.0 501891.0 504295.0 48816.0 49432.3 71336.9 71718.3 71722.6 47732.5 48303.5 48352.8 48616.8 48855.5 16708.2 16767.0 16929.9 16995.2 16997.7 13317.6 13405.4 13419.0 13475.0 13479.9 15454.2 15764.8 15773.5 15831.9 15860.2 5576.3 5593.6 5755.9 6623.8 6639.7 962.4 1033.4 1060.9 1115.3 1145.7 30288.4 30796.0 31206.8 31245.8 31255.7 1111.0 1147.3 1170.7 1210.8 1265.7 12733.8 14754.9 15236.6 15800.7 15826.7 522955.0 524992.0 525460.0 528417.0 529323.0 62573.7 64215.7 64325.0 64375.4 64727.7 1520.9 1522.0 1537.4 1544.7 1547.4 29772.6 30368.0 30704.0 30733.6 30825.0 55450.1 55516.0 56081.4 56155.7 56195.7 505804.0 505856.0 507606.0 508949.0 509102.0 35405.1 35789.6 45940.9 46660.0 47761.0 44916.6 45270.8 45396.3 45486.3 45889.0 27611.9 35606.5 37401.0 37919.6 37985.4 37041.8 37451.8 37714.8 38748.6 39050.8 34285.7 38828.4 39880.8 40512.8 40639.8 25116.6 31125.2 33075.5 33389.8 33598.0 23583.3 24366.5 25397.9 25462.0 25532.0 09:11:45 INFO - PROCESS | 1653 | 09:11:45 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:33938.51 Median:21249.08 stddev:96860.21 (455.8%) stddev-sans-first:97099.13 09:11:45 INFO - PROCESS | 1653 | Values: 369.2 375.9 377.7 379.4 381.1 17258.6 20322.3 20600.7 21159.6 21174.6 21120.6 21166.3 21210.7 21456.7 21580.5 5191.9 5774.7 6039.6 6065.8 6076.1 4573.3 5700.7 5751.2 6154.9 6156.0 6103.7 6118.2 6131.5 6146.0 6157.7 5538.0 5792.4 5804.4 5809.4 5821.4 5391.9 5546.4 5551.6 5569.2 5659.8 13214.9 13518.9 13520.5 13672.8 14037.3 2129.6 2246.3 2250.3 2541.2 2606.8 10068.2 10263.3 10285.1 13549.8 13830.4 1636.9 1641.7 1714.2 1755.9 1767.9 100638.5 107130.0 113037.0 113064.0 114056.9 9827.6 11138.7 11237.2 11397.0 11476.6 11712.9 14085.4 14139.9 14278.4 14342.5 7342.1 8664.4 8990.7 9041.7 9119.9 7902.6 8032.6 9157.5 9268.1 9299.4 4164.3 4434.8 4551.7 4554.6 4583.0 1567.3 1830.3 1869.8 1897.7 1922.0 897.0 969.6 1027.4 1047.1 1105.9 20617.3 21160.0 21247.5 21250.7 21335.9 981.8 997.3 1014.3 1024.8 1041.8 11093.0 11505.4 11563.4 11564.9 11599.4 522797.4 528215.0 529839.0 625615.0 678132.0 91863.0 128402.4 130756.0 132277.0 137444.0 1076.3 1079.3 1079.8 1126.5 1126.5 18056.0 18768.0 18974.8 19041.5 19458.0 54208.0 54666.5 54808.6 55125.0 56160.2 77525.6 77748.2 78180.0 78882.2 78908.2 7916.7 8042.9 8156.5 8262.0 8392.4 13142.3 13248.6 13340.3 13355.2 13563.1 9591.2 11483.4 11538.7 11790.8 12045.5 9668.9 9967.6 11262.8 11464.9 11804.2 11498.3 11672.9 11805.8 12045.2 12126.9 7206.1 8239.6 8277.5 8428.8 8575.2 9929.3 11649.3 11697.1 11726.9 12063.2 09:11:45 INFO - PROCESS | 1653 | 09:11:45 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:6230.51 Median:527.76 stddev:3274.01 (620.4%) stddev-sans-first:3265.28 09:11:45 INFO - PROCESS | 1653 | Values: 1673.1 1704.4 1756.5 1766.8 2094.6 7971.5 8134.9 8847.6 9019.3 9270.3 8892.6 8926.2 9027.1 9040.6 9060.1 2538.0 2563.6 2574.3 2581.9 2592.6 2511.6 2533.5 2535.1 2535.6 2546.6 2524.7 2525.4 2534.4 2580.7 2591.2 2528.2 2545.9 2553.2 2566.6 2571.7 2524.6 2548.6 2548.6 2549.6 2570.0 9194.2 9199.0 9208.4 9216.7 9221.0 5707.7 5753.7 5774.8 5856.5 5891.2 3576.7 3665.3 3669.3 3731.3 3739.4 1032.5 1053.5 1056.4 1066.0 1068.5 10418.3 12367.6 12428.6 12436.4 12469.9 4986.6 4998.1 5117.6 5122.9 5134.9 8885.7 10548.2 10563.4 10579.3 10607.3 5641.5 5702.5 5750.8 5762.5 5762.6 4650.2 5030.6 5134.7 5160.8 5170.8 4092.5 4101.9 4159.5 4169.2 4198.1 1253.3 1347.7 1365.4 1392.4 1398.2 1415.9 1440.9 1454.5 1465.6 1477.4 8449.5 8462.4 8496.7 8514.7 8555.4 517.7 522.4 523.3 532.2 532.6 6239.5 6330.7 6356.4 6375.4 6387.2 10918.4 11175.2 11183.8 11227.5 11285.8 10694.6 10987.0 11061.1 11154.1 11203.6 7298.3 8530.8 8573.0 8700.5 8736.4 6892.8 8034.0 8147.8 8245.9 8293.5 8608.1 9305.8 9783.3 9793.2 9815.6 9996.0 10092.2 10178.6 10198.8 10305.3 7521.2 7640.4 7686.4 7763.4 7800.1 8500.2 8562.1 8571.7 8574.1 8582.5 7432.8 7617.4 7631.6 7718.0 7744.5 6896.2 7471.7 7524.1 7558.8 7625.4 7531.7 8054.9 8105.0 8114.2 8152.0 7097.6 7286.8 7302.4 7307.2 7355.0 7302.6 7315.0 7333.0 7337.3 7449.0 09:11:45 INFO - PROCESS | 1653 | 09:11:45 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:5943.94 Median:6752.81 stddev:1954.87 (28.9%) stddev-sans-first:1913.50 09:11:45 INFO - PROCESS | 1653 | Values: 276.0 314.9 340.1 344.8 345.2 6255.5 6524.9 6843.3 6941.1 7028.9 6877.7 6882.3 6886.0 6897.6 6924.1 4036.8 4752.6 4882.6 5015.5 5035.6 4936.9 4971.8 4979.3 4979.3 4987.2 4923.5 4999.6 5005.5 5008.5 5030.3 5008.0 5013.0 5015.5 5020.9 5026.4 3544.9 4271.8 4282.2 4295.4 4298.0 5385.6 6642.4 6692.5 6741.1 6741.4 4938.2 5720.9 5800.1 5859.2 5894.9 6002.8 7386.7 7393.6 7401.4 7405.9 4664.1 4677.5 4677.8 4690.0 4694.9 7341.7 7703.9 7770.2 7798.0 7800.7 4529.7 4610.5 4716.1 4745.1 4765.0 4821.6 4859.4 4860.0 4862.7 4863.7 4737.8 5835.2 5845.7 5860.3 5869.1 5266.9 6377.5 6779.8 6997.4 7347.7 1653.8 1667.6 1673.8 1679.8 1687.7 1011.7 1042.9 1044.5 1061.7 1063.3 5872.2 6717.5 6811.7 6837.3 6925.3 5357.3 7113.0 7113.3 7614.7 7642.7 6764.3 6776.3 6785.4 6796.3 6820.1 3927.7 4009.7 4038.6 4047.2 4050.2 8046.6 8048.3 8069.5 8072.0 8081.6 7961.7 8006.9 8012.6 8036.1 8047.7 8013.6 8029.7 8036.4 8058.4 8070.7 7396.7 7629.6 7686.7 7724.7 7756.7 7522.6 7563.4 7565.6 7572.8 7578.0 8005.3 8008.8 8024.9 8036.0 8056.1 4693.8 4748.6 4749.4 4756.5 4782.4 6633.2 7317.4 7483.7 7717.8 7743.9 6446.2 7340.2 7394.9 7439.2 7516.2 6126.6 7396.9 7461.0 7461.9 7492.4 6986.8 7250.0 7259.3 7268.5 7295.2 7406.0 7418.4 7461.4 7472.3 7483.4 7190.9 7236.3 7241.3 7260.1 7269.8 09:11:45 INFO - PROCESS | 1653 | 09:11:45 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:18493.39 Median:4400.83 stddev:26208.80 (595.5%) stddev-sans-first:26248.12 09:11:45 INFO - PROCESS | 1653 | Values: 660.2 676.7 774.8 803.7 810.3 15203.0 15299.3 15423.9 15429.2 15487.5 14163.4 14166.0 14197.9 14226.5 14241.4 764.3 947.6 955.3 982.8 986.6 906.4 951.5 969.7 971.8 977.4 998.9 999.3 1040.5 1042.2 1047.3 1043.1 1044.0 1044.9 1046.1 1049.4 754.7 772.0 776.5 787.7 792.9 15083.6 15156.1 15346.6 15428.2 15549.5 11144.4 13126.0 13263.5 13265.9 13716.0 8252.0 10055.3 10197.4 10592.9 10757.1 3476.0 3537.8 3556.8 3567.2 3818.9 53532.5 64940.0 83945.3 85827.1 91446.5 9670.5 9934.3 10008.3 10072.7 10094.8 21624.0 22118.6 22120.2 23483.2 24010.2 6688.6 7649.8 7816.0 8065.7 8099.6 3938.6 4200.1 4245.4 4303.3 4498.4 3721.1 3725.0 3754.2 3773.9 3774.2 669.1 677.7 682.1 689.7 693.2 525.3 607.4 616.7 624.6 628.1 8074.6 8425.7 8464.7 8606.9 8625.8 548.4 611.2 614.1 630.9 633.9 3504.0 3897.5 3952.6 4015.3 4076.0 67034.0 96321.0 96485.0 97841.0 100372.0 86346.0 86422.0 87068.6 87965.6 90579.0 30736.2 30800.8 74579.0 76186.9 78780.8 7249.2 8514.2 8810.4 8908.6 8931.9 51041.5 52398.0 53090.7 53708.7 53976.9 69649.3 72448.0 72764.6 73433.0 75249.2 11178.4 11196.0 11272.2 11415.5 11653.4 11977.4 12098.9 12148.4 12229.5 13053.5 11309.8 11734.2 11876.5 12089.0 12274.9 11540.3 11914.8 11957.8 12134.2 12278.0 11330.6 11468.9 11660.4 11850.7 11904.0 9648.6 9764.7 9923.3 9931.9 9960.0 9705.6 10028.4 10094.2 10101.1 10127.5 09:11:45 INFO - PROCESS | 1653 | -------- Summary: end -------- 09:11:45 INFO - PROCESS | 1653 | 09:11:46 INFO - TEST-INFO | 1653: exit 0 09:11:46 INFO - TEST-OK | dromaeo_css | took 1110568ms 09:11:46 INFO - TEST-START | kraken 09:11:46 INFO - operating with platform_type : mac_ 09:11:46 INFO - Initialising browser for kraken test... 09:11:46 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpaGtNTB/profile http://localhost:49269/getInfo.html) 09:11:48 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 09:11:48 INFO - PROCESS | 1664 | colorDepth:24 09:11:48 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 09:11:48 INFO - PROCESS | 1664 | __metrics 09:11:49 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 09:11:49 INFO - TEST-INFO | 1664: exit 0 09:11:49 INFO - Browser initialized. 09:11:49 INFO - Running cycle 1/1 for kraken test... 09:11:49 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpaGtNTB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:12:01 INFO - PROCESS | 1667 | RSS: Main: 218042368 09:12:01 INFO - PROCESS | 1667 | 09:12:04 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 09:12:05 INFO - PROCESS | 1667 | RSS: Main: 229990400 09:12:05 INFO - PROCESS | 1667 | 09:12:07 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 09:12:08 INFO - PROCESS | 1667 | RSS: Main: 238997504 09:12:08 INFO - PROCESS | 1667 | 09:12:11 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 09:12:12 INFO - PROCESS | 1667 | RSS: Main: 243290112 09:12:12 INFO - PROCESS | 1667 | 09:12:14 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 09:12:14 INFO - PROCESS | 1667 | RSS: Main: 244629504 09:12:14 INFO - PROCESS | 1667 | 09:12:16 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:12:17 INFO - PROCESS | 1667 | RSS: Main: 244867072 09:12:17 INFO - PROCESS | 1667 | 09:12:20 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 09:12:20 INFO - PROCESS | 1667 | RSS: Main: 244944896 09:12:20 INFO - PROCESS | 1667 | 09:12:23 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 09:12:24 INFO - PROCESS | 1667 | RSS: Main: 244285440 09:12:24 INFO - PROCESS | 1667 | 09:12:27 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 09:12:27 INFO - PROCESS | 1667 | RSS: Main: 244310016 09:12:27 INFO - PROCESS | 1667 | 09:12:29 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:12:29 INFO - PROCESS | 1667 | RSS: Main: 244350976 09:12:29 INFO - PROCESS | 1667 | 09:12:31 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:12:32 INFO - PROCESS | 1667 | RSS: Main: 244346880 09:12:32 INFO - PROCESS | 1667 | 09:12:34 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:12:35 INFO - PROCESS | 1667 | RSS: Main: 245387264 09:12:35 INFO - PROCESS | 1667 | 09:12:37 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:12:38 INFO - PROCESS | 1667 | RSS: Main: 245592064 09:12:38 INFO - PROCESS | 1667 | 09:12:40 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:12:41 INFO - PROCESS | 1667 | RSS: Main: 244973568 09:12:41 INFO - PROCESS | 1667 | 09:12:43 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 09:12:43 INFO - PROCESS | 1667 | RSS: Main: 246669312 09:12:43 INFO - PROCESS | 1667 | 09:12:43 INFO - PROCESS | 1667 | __start_tp_report 09:12:43 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 09:12:43 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 09:12:43 INFO - PROCESS | 1667 | |i|pagename|runs| 09:12:43 INFO - PROCESS | 1667 | |0;ai-astar;148;89;158;126;155;193;162;120;148;166 09:12:43 INFO - PROCESS | 1667 | |1;audio-beat-detection;148;119;149;148;122;137;118;146;148;119 09:12:43 INFO - PROCESS | 1667 | |2;audio-dft;191;199;239;201;197;194;193;196;196;194 09:12:43 INFO - PROCESS | 1667 | |3;audio-fft;68;68;71;110;58;55;59;62;153;86 09:12:43 INFO - PROCESS | 1667 | |4;audio-oscillator;76;126;164;101;84;83;122;82;79;120 09:12:43 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;89;87;89;86;89;86;111;87;90;86 09:12:43 INFO - PROCESS | 1667 | |6;imaging-darkroom;94;95;94;94;94;95;95;151;129;95 09:12:43 INFO - PROCESS | 1667 | |7;imaging-desaturate;92;93;92;92;92;91;99;144;141;90 09:12:43 INFO - PROCESS | 1667 | |8;json-parse-financial;54;62;60;61;60;60;62;67;64;54 09:12:43 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;65;82;107;100;78;71;67;71;96;99 09:12:43 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;82;82;83;87;83;84;83;82;81;85 09:12:43 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;120;123;125;107;119;125;120;120;122;132 09:12:43 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;153;150;137;137;158;130;138;134;171;176 09:12:43 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;66;67;65;67;66;67;65;66;67;64 09:12:43 INFO - PROCESS | 1667 | __end_tp_report 09:12:43 INFO - PROCESS | 1667 | __start_cc_report 09:12:43 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,919 09:12:43 INFO - PROCESS | 1667 | __end_cc_report 09:12:43 INFO - PROCESS | 1667 | __startTimestamp1461082363365__endTimestamp 09:12:43 INFO - PROCESS | 1667 | 09:12:43 INFO - PROCESS | 1667 | ------- Summary: start ------- 09:12:43 INFO - PROCESS | 1667 | Number of tests: 14 09:12:43 INFO - PROCESS | 1667 | 09:12:43 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:146.50 Median:160.00 stddev:28.71 (17.9%) stddev-sans-first:30.45 09:12:43 INFO - PROCESS | 1667 | Values: 148.0 89.0 158.0 126.0 155.0 193.0 162.0 120.0 148.0 166.0 09:12:43 INFO - PROCESS | 1667 | 09:12:43 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:135.40 Median:147.00 stddev:14.13 (9.6%) stddev-sans-first:14.23 09:12:43 INFO - PROCESS | 1667 | Values: 148.0 119.0 149.0 148.0 122.0 137.0 118.0 146.0 148.0 119.0 09:12:43 INFO - PROCESS | 1667 | 09:12:43 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:200.00 Median:196.50 stddev:14.01 (7.1%) stddev-sans-first:14.47 09:12:43 INFO - PROCESS | 1667 | Values: 191.0 199.0 239.0 201.0 197.0 194.0 193.0 196.0 196.0 194.0 09:12:43 INFO - PROCESS | 1667 | 09:12:43 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:79.00 Median:65.00 stddev:30.73 (47.3%) stddev-sans-first:32.33 09:12:43 INFO - PROCESS | 1667 | Values: 68.0 68.0 71.0 110.0 58.0 55.0 59.0 62.0 153.0 86.0 09:12:43 INFO - PROCESS | 1667 | 09:12:43 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:103.70 Median:77.50 stddev:28.69 (37.0%) stddev-sans-first:28.62 09:12:43 INFO - PROCESS | 1667 | Values: 76.0 126.0 164.0 101.0 84.0 83.0 122.0 82.0 79.0 120.0 09:12:43 INFO - PROCESS | 1667 | 09:12:43 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:90.00 Median:88.00 stddev:7.53 (8.6%) stddev-sans-first:7.98 09:12:43 INFO - PROCESS | 1667 | Values: 89.0 87.0 89.0 86.0 89.0 86.0 111.0 87.0 90.0 86.0 09:12:43 INFO - PROCESS | 1667 | 09:12:43 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:103.60 Median:94.50 stddev:19.88 (21.0%) stddev-sans-first:20.78 09:12:43 INFO - PROCESS | 1667 | Values: 94.0 95.0 94.0 94.0 94.0 95.0 95.0 151.0 129.0 95.0 09:12:43 INFO - PROCESS | 1667 | 09:12:43 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:102.60 Median:92.00 stddev:21.18 (23.0%) stddev-sans-first:22.11 09:12:43 INFO - PROCESS | 1667 | Values: 92.0 93.0 92.0 92.0 92.0 91.0 99.0 144.0 141.0 90.0 09:12:43 INFO - PROCESS | 1667 | 09:12:43 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:60.40 Median:61.50 stddev:4.01 (6.5%) stddev-sans-first:3.52 09:12:43 INFO - PROCESS | 1667 | Values: 54.0 62.0 60.0 61.0 60.0 60.0 62.0 67.0 64.0 54.0 09:12:43 INFO - PROCESS | 1667 | 09:12:43 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:83.60 Median:74.50 stddev:15.56 (20.9%) stddev-sans-first:14.98 09:12:43 INFO - PROCESS | 1667 | Values: 65.0 82.0 107.0 100.0 78.0 71.0 67.0 71.0 96.0 99.0 09:12:43 INFO - PROCESS | 1667 | 09:12:43 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.00 stddev:1.75 (2.1%) stddev-sans-first:1.80 09:12:43 INFO - PROCESS | 1667 | Values: 82.0 82.0 83.0 87.0 83.0 84.0 83.0 82.0 81.0 85.0 09:12:43 INFO - PROCESS | 1667 | 09:12:43 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:122.50 stddev:6.33 (5.2%) stddev-sans-first:6.69 09:12:43 INFO - PROCESS | 1667 | Values: 120.0 123.0 125.0 107.0 119.0 125.0 120.0 120.0 122.0 132.0 09:12:43 INFO - PROCESS | 1667 | 09:12:43 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.40 Median:151.50 stddev:15.99 (10.6%) stddev-sans-first:16.88 09:12:43 INFO - PROCESS | 1667 | Values: 153.0 150.0 137.0 137.0 158.0 130.0 138.0 134.0 171.0 176.0 09:12:43 INFO - PROCESS | 1667 | 09:12:43 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.50 stddev:1.05 (1.6%) stddev-sans-first:1.12 09:12:43 INFO - PROCESS | 1667 | Values: 66.0 67.0 65.0 67.0 66.0 67.0 65.0 66.0 67.0 64.0 09:12:43 INFO - PROCESS | 1667 | -------- Summary: end -------- 09:12:43 INFO - PROCESS | 1667 | 09:12:44 INFO - TEST-INFO | 1667: exit 0 09:12:44 INFO - TEST-OK | kraken | took 57777ms 09:12:44 INFO - SUITE-END | took 1168s 09:12:44 INFO - Completed test suite (00:19:28) 09:12:44 INFO - javascript benchmark 09:12:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2994.745446637036, 3506.263684626229, 3561.6972557332642, 3615.6926661233792, 3630.3102410541997, 5842.386549412315, 5852.795152169675, 5858.0, 5862.384449632791, 5898.941010589893, 5821.09772985188, 5835.270591176103, 5862.648241105526, 5873.207117039198, 5877.265341832271, 5252.6848389096585, 5289.127293996486, 5334.1732031535175, 5369.62412631116, 5406.243125962349, 5268.446813084628, 5337.626366154371, 5366.141417373221, 5384.7846086156505, 5407.297051383314, 5280.287161233242, 5340.67955922644, 5371.650842695231, 5378.596605254622, 5424.783008679668, 4197.958020419787, 5407.297051383295, 5408.296921400232, 5414.83755487336, 5423.078076726966, 5258.868528286824, 5305.336832895888, 5311.203319502067, 5332.573394128461, 5360.571154307646, 5635.633683810539, 5643.68959707216, 5647.519960803336, 5701.315842098975, 5733.426657334233, 6209.813705588839, 6262.2798378186635, 6272.968635156795, 6303.9684801575695, 6306.369363063703, 6335.936640633627, 6340.112384266206, 6344.3655634436645, 6349.619022858597, 6355.8411039723915, 5809.390014048507, 5955.821325360246, 6019.668918209497, 6028.065649824284, 6086.604370715978, 6386.10594516768, 6435.324290949477, 6436.388543088399, 6439.581427207217, 6458.773942911976, 6242.937570624235, 6266.530010249249, 6271.278802937721, 6283.622982621057, 6292.402221788922, 6204.193454850841, 6248.062790581358, 6279.215098112736, 6320.778772743024, 6328.0, 6235.127082208494, 6249.0, 6288.874222515524, 6296.65368404733, 6316.30520642729, 6180.845478863064, 6281.089242059876, 6285.685715714196, 6294.779682711083, 6332.303446620868, 4946.530079642428, 4979.551840334388, 4986.052649996562, 4986.476419975923, 5020.297158397827, 4458.598726114666, 4468.597826195593, 4498.482674492409, 4503.864884053483, 4508.368828364031, 5752.626079304831, 5860.062390017577, 5893.057110862242, 5894.056950887837, 5897.439743224387, 4823.975880120577, 5221.843344699665, 5573.108302671553, 5776.682282474504, 6341.207349081365, 4955.2567114933045, 5881.852953676107, 5932.58471906971, 5945.554083443759, 5950.523958083343, 5389.0299746046085, 5399.757010934517, 5471.452854714496, 5490.368607610176, 5524.392316845144, 6286.277078135981, 6453.774117905851, 6466.0, 6481.0, 6489.123968264318, 6263.906041409291, 6295.842603934755, 6300.842478938063, 6302.684865756785, 6302.9684851577285, 5063.620228482952, 5396.325459317585, 6434.2922278548385, 6497.707603157774, 6528.608283503005, 6011.909821352596, 6267.4045965633195, 6278.309385967448, 6304.085907543472, 6329.5252856036905, 5067.189249720027, 5719.48524632785, 6283.183186185766, 6295.213098362705, 6303.2436107665535, 6119.510439164945, 6123.5876691309595, 6227.1282020516255, 6228.941080016318, 6246.156768836149, 6199.225096862892, 6199.225096862892, 6214.25428948529, 6219.626822390671, 6249.812505624838, 5471.534919531884, 6022.36765139654, 6060.181875446759, 6067.302260240129, 6102.237220347457, 6113.932424433873, 6156.938430615636, 6229.56393052482, 6252.3122456530655, 6255.468285195628, 6041.969790151021, 6117.969410153099, 6124.234470691164, 6130.693465326805, 6151.96924015395], "unit": "score", "name": "dojo.html", "value": 5752.3119188075825}, {"lowerIsBetter": false, "replicates": [572.4361503918642, 579.9908159801946, 639.2552676132306, 676.7547712209533, 679.5107522583739, 38659.42010869836, 39269.41095883564, 39385.621503247356, 39387.60612393875, 39463.80268098663, 40716.98207544805, 41213.38179927303, 41313.38029929546, 41358.17283654325, 41361.58638413615, 9432.292578056638, 9609.615615375376, 9641.951790241039, 9659.082387173243, 9695.078967498112, 8195.262426381625, 8378.790530236762, 9679.225661947063, 9693.127618514332, 9722.513874306293, 9658.75853103671, 9663.806723865519, 9685.75785605362, 9779.951100244525, 9787.90212097877, 8552.0, 9633.325667203299, 9675.225981921465, 9685.41887486753, 9749.36629119105, 8372.748817535483, 9721.611135554569, 9766.755831104208, 9794.167495762798, 9811.411315321104, 40374.59625403738, 40402.191956161005, 40685.79657101725, 40732.0, 40735.59264407348, 3156.889508867179, 3362.8822991195434, 3827.158025234444, 3866.8646597368956, 3940.133170702441, 28885.277868053257, 29371.0, 29437.705622943926, 29459.558106628418, 29507.70492295071, 2601.388673661707, 2640.7227241139594, 2641.418887844671, 2685.328667833042, 2708.7832973362083, 478703.0, 496912.0, 499027.0, 501891.0, 504295.0, 48816.02367952621, 49432.25851612229, 71336.92994604982, 71718.2828171722, 71722.64138679273, 47732.52267477281, 48303.516964830604, 48352.758236209294, 48616.75691621519, 48855.511444885095, 16708.24812883423, 16767.0, 16929.915350423416, 16995.150242487827, 16997.745033824503, 13317.600471985856, 13405.396757145756, 13418.993575481878, 13475.0, 13479.932600336935, 15454.227288635524, 15764.842351576566, 15773.526794196192, 15831.920840395724, 15860.20698965047, 5576.275084239104, 5593.580481463825, 5755.85610359736, 6623.8077146114165, 6639.701213445406, 962.4081190068198, 1033.4367769565604, 1060.8726952765717, 1115.341948250536, 1145.7135716070982, 30288.394232115676, 30796.0, 31206.84396578048, 31245.843770781, 31255.687443125276, 1110.9500072496758, 1147.3345459633392, 1170.6546568762235, 1210.8002179640437, 1265.7088869560052, 12733.808992865115, 14754.893382996319, 15236.619084522976, 15800.683986320439, 15826.683466330609, 522955.0, 524992.0, 525460.0, 528417.0, 529323.0, 62573.68713156496, 64215.67892160603, 64325.03512447317, 64375.35624643787, 64727.67636161789, 1520.8707259882813, 1522.0, 1537.3927298716944, 1544.6833399153147, 1547.396515359011, 29772.55341169841, 30368.0, 30704.0, 30733.589198003745, 30825.0, 55450.05924792613, 55516.0, 56081.439185609255, 56155.71922140363, 56195.71902140463, 505804.0, 505856.0, 507606.0, 508949.0, 509102.0, 35405.11487212737, 35789.642103579674, 45940.8514787133, 46660.0, 47761.044779104916, 44916.55083449124, 45270.77364613156, 45396.31905521486, 45486.317705233785, 45889.0, 27611.861940690167, 35606.465903010954, 37401.0, 37919.62080379271, 37985.4302185473, 37041.81479092587, 37451.81274093612, 37714.811425942695, 38748.6125138745, 39050.82044769824, 34285.657143428245, 38828.41757373698, 39880.800595996836, 40512.79743601263, 40639.79680101581, 25116.62325065089, 31125.221869453446, 33075.50386744249, 33389.83305083459, 33598.0, 23583.29250122499, 24366.512669746153, 25397.87301063483, 25461.981520738962, 25532.0], "unit": "score", "name": "ext.html", "value": 19909.664034320474}, {"lowerIsBetter": false, "replicates": [369.1712106321309, 375.8985074030012, 377.74964866292555, 379.4270651316512, 381.1310212715011, 17258.568535786595, 20322.28871989481, 20600.69098963513, 21159.576808463822, 21174.57650846982, 21120.57758844822, 21166.25918092867, 21210.681839772376, 21456.678149827763, 21580.460488487795, 5191.922121168185, 5774.682392468402, 6039.607425517349, 6065.787697430591, 6076.058210977306, 4573.291139873309, 5700.6579605223615, 5751.217122691979, 6154.876902461948, 6156.045812899008, 6103.664298463583, 6118.174046503709, 6131.47882429994, 6146.0, 6157.661328626924, 5537.972310138443, 5792.420757924216, 5804.419558044183, 5809.448102430262, 5821.359650438449, 5391.919121213145, 5546.362168350611, 5551.611387202897, 5569.220309156722, 5659.801906933238, 13214.933925330408, 13518.93240533791, 13520.526781562598, 13672.794908076386, 14037.298135093306, 2129.6273152198305, 2246.2811900191946, 2250.324902529251, 2541.1741184115235, 2606.7914566834606, 10068.244881633907, 10263.281570290083, 10285.07268409499, 13549.796753048711, 13830.446782128703, 1636.869050475959, 1641.662903281838, 1714.211462727147, 1755.9297628094862, 1767.9116044197867, 100638.49680751623, 107130.0, 113037.0, 113064.0, 114056.85943140545, 9827.606895724091, 11138.665840024812, 11237.21339506243, 11396.974272315532, 11476.598319058792, 11712.941435292769, 14085.43658253679, 14139.85860141406, 14278.42886284537, 14342.49801256951, 7342.118945726547, 8664.35017373687, 8990.685326013558, 9041.654587802555, 9119.863202051974, 7902.565358905201, 8032.59837008159, 9157.496337701357, 9268.073192680678, 9299.395539289924, 4164.333706606928, 4434.82260709568, 4551.704139230939, 4554.63562914966, 4582.991741816795, 1567.3025503650765, 1830.2770405689944, 1869.7943226245102, 1897.7343171955938, 1921.9615607687767, 896.9775755606162, 969.6024629901707, 1027.3681685763202, 1047.0628787235382, 1105.8949399807007, 20617.278395256093, 21160.0, 21247.468813279793, 21250.681239781417, 21335.893320533298, 981.8301553566697, 997.3467378866853, 1014.2595904989399, 1024.8411496218098, 1041.7551875309296, 11093.00162985319, 11505.367204803817, 11563.42182890852, 11564.90133437322, 11599.362035088152, 522797.3860130751, 528215.0, 529839.0, 625615.0, 678132.0, 91863.0, 128402.35798820946, 130756.0, 132277.0, 137444.0, 1076.2520048566328, 1079.3254216114772, 1079.7624522605172, 1126.4536699700639, 1126.487448211062, 18056.020087758956, 18768.0, 18974.810251897303, 19041.523961900508, 19458.0, 54208.0, 54666.45333546614, 54808.62978425412, 55125.0, 56160.157597636884, 77525.61237193778, 77748.22251777409, 78180.0, 78882.21117788748, 78908.21091789239, 7916.683332666629, 8042.879356809535, 8156.469829461066, 8262.049864265686, 8392.412531123007, 13142.277174755098, 13248.602541923758, 13340.266285354399, 13355.198688078746, 13563.118397304144, 9591.232701383733, 11483.36841473727, 11538.653840384803, 11790.764184716429, 12045.518179273082, 9668.903310967082, 9967.601295948081, 11262.774744505228, 11464.885351146715, 11804.232724872856, 11498.25261358009, 11672.88327116718, 11805.76388472243, 12045.156839021534, 12126.878731212575, 7206.135263768381, 8239.588020598827, 8277.503349799032, 8428.831423371375, 8575.22822945913, 9929.255305851946, 11649.301041937511, 11697.122715796178, 11726.94136529312, 12063.21589096706], "unit": "score", "name": "jquery.html", "value": 9494.760958081548}, {"lowerIsBetter": false, "replicates": [1673.113249977512, 1704.3864208884804, 1756.490617720861, 1766.816233123807, 2094.57061302433, 7971.485417770627, 8134.918650813505, 8847.646094156242, 9019.323550733696, 9270.258379329654, 8892.555372231378, 8926.2412694921, 9027.14242146995, 9040.593173307201, 9060.093990600937, 2537.9746202538017, 2563.6026415905562, 2574.253466494724, 2581.90963316284, 2592.62406950992, 2511.6483692283095, 2533.5439620868237, 2535.1000394859834, 2535.5816290312077, 2546.567083595793, 2524.7475252474787, 2525.4065294655743, 2534.4170840706647, 2580.664513613237, 2591.222633210039, 2528.2415275417393, 2545.8599777012255, 2553.1957433408415, 2566.615007748834, 2571.742825717432, 2524.5960646296503, 2548.554003049459, 2548.566743653583, 2549.5665736824785, 2570.0490818397125, 9194.17252447283, 9198.954005229998, 9208.401453905542, 9216.677416290464, 9221.0, 5707.71461426927, 5753.654780713129, 5774.82675519735, 5856.502197313233, 5891.234139561872, 3576.6959808416054, 3665.2669466106886, 3669.321175582499, 3731.328360895038, 3739.420389839579, 1032.4785983078573, 1053.5469748008354, 1056.4084112896803, 1065.957361705531, 1068.4657671164418, 10418.322809017389, 12367.62897113088, 12428.62714118578, 12436.440360183722, 12469.937650311782, 4986.601071914238, 4998.050370429607, 5117.616178786606, 5122.948770512322, 5134.948650513522, 8885.689000885068, 10548.156147508182, 10563.419011954262, 10579.259451838298, 10607.257491975488, 5641.492265696107, 5702.515286200636, 5750.827475175752, 5762.538996880239, 5762.567807414461, 4650.186217412007, 5030.597552195815, 5134.691918484903, 5160.767765450564, 5170.767315470813, 4092.4992411160842, 4101.938470922939, 4159.500859896832, 4169.1661667666585, 4198.1393814268, 1253.348258905364, 1347.7263985533773, 1365.3514580574147, 1392.4291040673274, 1398.175076704749, 1415.9362828672733, 1440.942362305517, 1454.4836583013089, 1465.5823090419392, 1477.4385733421232, 8449.535275559903, 8462.407631465861, 8496.70261540843, 8514.74455766328, 8555.358348123791, 517.6893863681836, 522.4227228911998, 523.3353640876066, 532.1777853216789, 532.5553163108771, 6239.532035097295, 6330.651814150266, 6356.364363563699, 6375.3624637536805, 6387.233531976192, 10918.399488028235, 11175.21773475849, 11183.83224251637, 11227.494762735696, 11285.830712539318, 10694.572217111228, 10987.0, 11061.11511079128, 11154.10767138627, 11203.551857925591, 7298.306660867209, 8530.829383412298, 8573.0, 8700.521471319138, 8736.388452808242, 6892.793216203522, 8034.0, 8147.75556733299, 8245.876311855207, 8293.460925039853, 8608.139186081342, 9305.8367704037, 9783.266255031043, 9793.216542676711, 9815.607375704893, 9995.950020249853, 10092.24308176875, 10178.643747468803, 10198.847017294895, 10305.278630495794, 7521.247875212435, 7640.3505702015955, 7686.385089192963, 7763.417743669134, 7800.1419843816, 8500.192481714228, 8562.143785621389, 8571.657133714582, 8574.09971952936, 8582.527960962207, 7432.814179645552, 7617.352525035212, 7631.580263085583, 7718.0, 7744.535327880345, 6896.172459304916, 7471.738489152854, 7524.05949256343, 7558.773236802905, 7625.428092893166, 7531.698732050657, 8054.879176812469, 8105.0, 8114.229148230908, 8151.959240203761, 7097.574145551283, 7286.781396558112, 7302.379297759538, 7307.159676637255, 7354.96322518384, 7302.598357090411, 7315.049043624294, 7332.96333518329, 7337.3029562191505, 7449.0], "unit": "score", "name": "mootools.html", "value": 5014.3627947385585}, {"lowerIsBetter": false, "replicates": [275.96826364968035, 314.86146095717885, 340.1004343511411, 344.82586293921565, 345.17847522895505, 6255.468285195752, 6524.890768569343, 6843.315668433154, 6941.09765730455, 7028.894566581499, 6877.724891004354, 6882.277360877111, 6886.001529778179, 6897.551659142165, 6924.134483189601, 4036.757794532323, 4752.619790416758, 4882.56056954874, 5015.523525265094, 5035.647504674675, 4936.925946110811, 4971.801127954877, 4979.28214765907, 4979.327790748257, 4987.202047672373, 4923.483034281403, 4999.600191907886, 5005.47442518534, 5008.524190201943, 5030.320906677588, 5008.0, 5013.0, 5015.523525265094, 5020.949790502084, 5026.396832380119, 3544.946825797615, 4271.765052922088, 4282.164977829325, 4295.441592592974, 4298.032942587924, 5385.623006389555, 6642.368974947421, 6692.46460283181, 6741.0899528563505, 6741.359570840762, 4938.160512712848, 5720.914186287209, 5800.1299805029585, 5859.209006784072, 5894.911576326359, 6002.8499287517725, 7386.741464048732, 7393.630318484054, 7401.370883474858, 7405.851882962311, 4664.113818374498, 4677.4854765975715, 4677.812887484497, 4689.953100468986, 4694.859154225379, 7341.669624866947, 7703.8844417333785, 7770.222977702241, 7797.956583647661, 7800.687972481151, 4529.705569137996, 4610.492845786961, 4716.127516409407, 4745.050989802054, 4764.952350476451, 4821.590164835958, 4859.3682821233015, 4860.0, 4862.659613827069, 4863.732494712754, 4737.839229388822, 5835.241418615553, 5845.7201691340415, 5860.2967643883, 5869.090291004901, 5266.894662106736, 6377.5216858735785, 6779.762708305186, 6997.39060016189, 7347.70609175627, 1653.768472413863, 1667.583104223944, 1673.7740405045163, 1679.8068222154363, 1687.7130887749113, 1011.7420057885192, 1042.9374237545771, 1044.511571011306, 1061.6655753437642, 1063.2716589136467, 5872.207252021008, 6717.496187785936, 6811.727530898807, 6837.282085381063, 6925.272846351161, 5357.276767636397, 7113.039739635186, 7113.253108423644, 7614.695412183451, 7642.656080476392, 6764.255931847493, 6776.288489708608, 6785.355391237825, 6796.286389929085, 6820.147481564804, 3927.7250592458827, 4009.7393669411395, 4038.6163314485075, 4047.1500984793524, 4050.210209009215, 8046.557439340892, 8048.315893149031, 8069.475484093515, 8071.9506464159285, 8081.555514446762, 7961.681532738741, 8006.919930800734, 8012.639431225609, 8036.075851277178, 8047.678092876219, 8013.639386227517, 8029.678812847537, 8036.4374493786045, 8058.435909486279, 8070.717524886601, 7396.6671499783715, 7629.618519073913, 7686.692532298645, 7724.6910123594425, 7756.650950707344, 7522.5862577558755, 7563.432742544442, 7565.621718914143, 7572.772816815284, 7577.962110189414, 8005.279524842559, 8008.799780005546, 8024.919750802417, 8036.035675718951, 8056.0735515414135, 4693.835715749932, 4748.572628463455, 4749.430068391815, 4756.524347565354, 4782.426108866958, 6633.2040155181685, 7317.414606831334, 7483.738069167771, 7717.807054823675, 7743.883841742491, 6446.194225721785, 7340.229275925951, 7394.926050739424, 7439.218882017527, 7516.173220945801, 6126.571140020156, 7396.890466430079, 7460.962695186489, 7461.925380746123, 7492.363149132385, 6986.825329366807, 7250.02124713157, 7259.346658800733, 7268.454865884974, 7295.161056478573, 7406.037215161994, 7418.443616728875, 7461.4403919705155, 7472.252774722484, 7483.401327893865, 7190.89213661785, 7236.348728614239, 7241.348278654947, 7260.128784545888, 7269.836826107798], "unit": "score", "name": "prototype.html", "value": 5285.696171300474}, {"lowerIsBetter": false, "replicates": [660.2242365220865, 676.6582875647797, 774.7791879314397, 803.710664160902, 810.3274282345653, 15203.0, 15299.311530981106, 15423.922880385582, 15429.228538573083, 15487.457938972138, 14163.362648680808, 14166.0, 14197.929010354934, 14226.502072427467, 14241.430342786276, 764.2701220334595, 947.5688561704443, 955.2930831184925, 982.8378317577591, 986.6102889358699, 906.4244204929884, 951.5242378810594, 969.7478655549537, 971.7910649210419, 977.3647129365897, 998.8901220865699, 999.2705325112672, 1040.4537617750705, 1042.1766804224653, 1047.2512153810023, 1043.1341986151476, 1044.0499145777344, 1044.9216308776834, 1046.1003536958285, 1049.3861091261545, 754.7433872483327, 771.9922800771976, 776.5418403142173, 787.7321710618418, 792.8771040488733, 15083.622909427242, 15156.090634561962, 15346.616334591612, 15428.228588570639, 15549.455769048142, 11144.442777861155, 13126.0, 13263.469461221635, 13265.933670331586, 13716.0, 8252.0, 10055.296129270953, 10197.439140847251, 10592.887746786553, 10757.139428845674, 3475.9652403475893, 3537.7699005780105, 3556.8043757593323, 3567.2152126532123, 3818.9045273868096, 53532.464675353134, 64939.99999999953, 83945.32109357779, 85827.14172858317, 91446.54276728573, 9670.468124253093, 9934.304598678023, 10008.299419040743, 10072.697819065439, 10094.848577271347, 21624.0, 22118.55762884733, 22120.2257920972, 23483.178088767152, 24010.15964441236, 6688.565243259172, 7649.847003059907, 7816.0, 8065.717699880476, 8099.635516401776, 3938.6455219030427, 4200.096979149497, 4245.3844192591905, 4303.289957157034, 4498.370228168059, 3721.14413684854, 3725.0314918120944, 3754.23038277158, 3773.9433908491396, 3774.150816066363, 669.10340144207, 677.6916502991127, 682.0894106368054, 689.6930865764687, 693.1612748574181, 525.3144646236698, 607.3531688751466, 616.7440512187482, 624.5815303746501, 628.0579131303045, 8074.555899425471, 8425.747227583182, 8464.66141354339, 8606.87089693655, 8625.827483450295, 548.4049805960577, 611.1718621268118, 614.1483427466193, 630.8706715123388, 633.9397757213058, 3504.001359612498, 3897.512810898638, 3952.5849785772657, 4015.257177422186, 4076.0, 67034.0, 96321.0, 96485.035149649, 97841.0, 100372.0, 86346.0, 86422.0, 87068.56465717757, 87965.56017219873, 90579.0, 30736.231594209876, 30800.845995769876, 74579.0, 76186.85719714209, 78780.81828772573, 7249.166345870292, 8514.233718965323, 8810.383273170817, 8908.643654253758, 8931.883514560679, 51041.46875593738, 52398.0, 53090.73454632702, 53708.731456342466, 53976.92046159133, 69649.3035069663, 72448.0, 72764.63617681878, 73433.0, 75249.23753812397, 11178.385188814693, 11196.0, 11272.154588405738, 11415.543378264776, 11653.359065251492, 11977.442565759355, 12098.93950530277, 12148.39258037077, 12229.510819567473, 13053.477860885838, 11309.830352544554, 11734.178607497393, 11876.465559050037, 12088.972437342924, 12274.895259426694, 11540.307581545134, 11914.821277680669, 11957.760844782882, 12134.211276267015, 12278.0, 11330.60342887995, 11468.94265528667, 11660.358680272666, 11850.703732406759, 11904.0, 9648.565472053839, 9764.707058788248, 9923.305368624417, 9931.851022234529, 9960.0, 9705.6117755289, 10028.398296102258, 10094.242931780293, 10101.090901818578, 10127.493625318852], "unit": "score", "name": "yui.html", "value": 7126.72637778716}], "name": "dromaeo_css", "value": 7681.369539213384}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [148.0, 89.0, 158.0, 126.0, 155.0, 193.0, 162.0, 120.0, 148.0, 166.0], "unit": "score", "name": "ai-astar", "value": 146.5}, {"lowerIsBetter": true, "replicates": [148.0, 119.0, 149.0, 148.0, 122.0, 137.0, 118.0, 146.0, 148.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 135.4}, {"lowerIsBetter": true, "replicates": [191.0, 199.0, 239.0, 201.0, 197.0, 194.0, 193.0, 196.0, 196.0, 194.0], "unit": "score", "name": "audio-dft", "value": 200.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 71.0, 110.0, 58.0, 55.0, 59.0, 62.0, 153.0, 86.0], "unit": "score", "name": "audio-fft", "value": 79.0}, {"lowerIsBetter": true, "replicates": [76.0, 126.0, 164.0, 101.0, 84.0, 83.0, 122.0, 82.0, 79.0, 120.0], "unit": "score", "name": "audio-oscillator", "value": 103.7}, {"lowerIsBetter": true, "replicates": [89.0, 87.0, 89.0, 86.0, 89.0, 86.0, 111.0, 87.0, 90.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 90.0}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 151.0, 129.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 103.6}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 92.0, 92.0, 92.0, 91.0, 99.0, 144.0, 141.0, 90.0], "unit": "score", "name": "imaging-desaturate", "value": 102.6}, {"lowerIsBetter": true, "replicates": [54.0, 62.0, 60.0, 61.0, 60.0, 60.0, 62.0, 67.0, 64.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 60.4}, {"lowerIsBetter": true, "replicates": [65.0, 82.0, 107.0, 100.0, 78.0, 71.0, 67.0, 71.0, 96.0, 99.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 83.6}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 83.0, 87.0, 83.0, 84.0, 83.0, 82.0, 81.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.2}, {"lowerIsBetter": true, "replicates": [120.0, 123.0, 125.0, 107.0, 119.0, 125.0, 120.0, 120.0, 122.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.3}, {"lowerIsBetter": true, "replicates": [153.0, 150.0, 137.0, 137.0, 158.0, 130.0, 138.0, 134.0, 171.0, 176.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.4}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 65.0, 67.0, 66.0, 67.0, 65.0, 66.0, 67.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.0}], "name": "kraken", "value": 1523.7}]} 09:12:44 INFO - Return code: 0 09:12:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:12:44 ERROR - # TBPL SUCCESS # 09:12:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:12:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:12:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:12:44 INFO - 2016-04-19 09:12:44.666 screenresolution[1672:10619] starting screenresolution argv=screenresolution get 09:12:44 INFO - 2016-04-19 09:12:44.668 screenresolution[1672:10619] Display 0: 1600x1200x32@60 09:12:44 INFO - 2016-04-19 09:12:44.674 screenresolution[1673:10622] starting screenresolution argv=screenresolution list 09:12:44 INFO - Available Modes on Display 0 09:12:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:12:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:12:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:12:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:12:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:12:44 INFO - Intel Iris: 09:12:44 INFO - Chipset Model: Intel Iris 09:12:44 INFO - Type: GPU 09:12:44 INFO - Bus: Built-In 09:12:44 INFO - VRAM (Dynamic, Max): 1536 MB 09:12:44 INFO - Vendor: Intel (0x8086) 09:12:44 INFO - Device ID: 0x0a2e 09:12:44 INFO - Revision ID: 0x0009 09:12:44 INFO - Displays: 09:12:44 INFO - Display: 09:12:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:12:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:12:44 INFO - Display Serial Number: 1600x1200 60 09:12:44 INFO - Main Display: Yes 09:12:44 INFO - Mirror: Off 09:12:44 INFO - Online: Yes 09:12:44 INFO - Rotation: Supported 09:12:44 INFO - Return code: 0 09:12:44 INFO - Running post-action listener: _resource_record_post_action 09:12:44 INFO - Running post-run listener: _resource_record_post_run 09:12:45 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 37733888; Write bytes: 668129792; Read time: 401; Write time: 1864 09:12:45 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 356485632; Write bytes: 354108928; Read time: 28164; Write time: 666 09:12:45 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 35919360; Write bytes: 302842880; Read time: 378; Write time: 1165 09:12:45 INFO - Running post-run listener: _upload_blobber_files 09:12:45 INFO - Blob upload gear active. 09:12:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:12:45 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:12:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:12:46 INFO - (blobuploader) - INFO - Open directory for files ... 09:12:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:12:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:12:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:48 INFO - (blobuploader) - INFO - Done attempting. 09:12:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:12:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:12:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:50 INFO - (blobuploader) - INFO - Done attempting. 09:12:50 INFO - (blobuploader) - INFO - Iteration through files over. 09:12:50 INFO - Return code: 0 09:12:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:12:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:12:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e91221f8c073c49e2454918dcf753b2b3852f66bb3f115a1b39d8bb106f60cd4f52106374aa882589e677891d7c9cd8028612b1daf06ae0434da635da7eb872", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/06f8d7f8f6ed79f093dd5b76aa2a5c2a561c8b1c479a226d728714ab2d15714c15c6f8f2a2138fad79add7a02ee89fcf5166eb0f8d5fd2f6b0bba90eeb5aa042"} 09:12:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:12:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:12:50 INFO - Contents: 09:12:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e91221f8c073c49e2454918dcf753b2b3852f66bb3f115a1b39d8bb106f60cd4f52106374aa882589e677891d7c9cd8028612b1daf06ae0434da635da7eb872", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/06f8d7f8f6ed79f093dd5b76aa2a5c2a561c8b1c479a226d728714ab2d15714c15c6f8f2a2138fad79add7a02ee89fcf5166eb0f8d5fd2f6b0bba90eeb5aa042"} 09:12:50 INFO - Running post-run listener: copy_logs_to_upload_dir 09:12:50 INFO - Copying logs to upload dir... 09:12:50 INFO - mkdir: /builds/slave/test/build/upload/logs 09:12:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.617037 ========= master_lag: 0.33 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-19 09:12:50.462672) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 5 secs) (at 2016-04-19 09:12:50.466095) ========= 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.u2ZiVl2QcF/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.82xR3U8KW3/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e91221f8c073c49e2454918dcf753b2b3852f66bb3f115a1b39d8bb106f60cd4f52106374aa882589e677891d7c9cd8028612b1daf06ae0434da635da7eb872", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/06f8d7f8f6ed79f093dd5b76aa2a5c2a561c8b1c479a226d728714ab2d15714c15c6f8f2a2138fad79add7a02ee89fcf5166eb0f8d5fd2f6b0bba90eeb5aa042"} build_url:https://queue.taskcluster.net/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010822 build_url: 'https://queue.taskcluster.net/v1/task/bPQ9p9p6TBqHWAU8RmgG_A/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e91221f8c073c49e2454918dcf753b2b3852f66bb3f115a1b39d8bb106f60cd4f52106374aa882589e677891d7c9cd8028612b1daf06ae0434da635da7eb872", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/06f8d7f8f6ed79f093dd5b76aa2a5c2a561c8b1c479a226d728714ab2d15714c15c6f8f2a2138fad79add7a02ee89fcf5166eb0f8d5fd2f6b0bba90eeb5aa042"}' ========= master_lag: 5.76 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 5 secs) (at 2016-04-19 09:12:56.232551) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-04-19 09:12:56.232917) ========= 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.u2ZiVl2QcF/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.82xR3U8KW3/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.005098 ========= master_lag: 1.17 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-04-19 09:12:57.406850) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 09:12:57.407194) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 09:12:57.497603) ========= ========= Total master_lag: 7.31 =========