builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0145 starttime: 1469548146.68 results: success (0) buildid: 20160726073802 builduid: 6c72781d2b374e1f98a541c9c018fb4c revision: 958cee08361af9ed370be06695973bcda3d3aa46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 08:49:06.681133) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 08:49:06.681612) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 08:49:06.681941) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 08:49:06.706495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 08:49:06.706864) ========= 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.rMZ3xf8UTn/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.5VKs5pjg1K/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-26 08:49:06-- 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% 148M=0s 2016-07-26 08:49:06 (148 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102605 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 08:49:06.832106) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 08:49:06.832461) ========= 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.rMZ3xf8UTn/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.5VKs5pjg1K/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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.026764 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 08:49:06.884185) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-26 08:49:06.884969) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 958cee08361af9ed370be06695973bcda3d3aa46 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 958cee08361af9ed370be06695973bcda3d3aa46 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rMZ3xf8UTn/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.5VKs5pjg1K/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-26 08:49:06,964 truncating revision to first 12 chars 2016-07-26 08:49:06,964 Setting DEBUG logging. 2016-07-26 08:49:06,964 attempt 1/10 2016-07-26 08:49:06,964 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/958cee08361a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-26 08:49:07,656 unpacking tar archive at: mozilla-beta-958cee08361a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.973839 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-26 08:49:07.885894) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 08:49:07.886724) ========= script_repo_revision: 958cee08361af9ed370be06695973bcda3d3aa46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 08:49:07.887398) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 08:49:07.887718) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 08:49:07.906217) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-07-26 08:49:07.906544) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rMZ3xf8UTn/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.5VKs5pjg1K/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:49:08 INFO - MultiFileLogger online at 20160726 08:49:08 in /builds/slave/test 08:49:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:49:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:49:08 INFO - {'append_to_log': False, 08:49:08 INFO - 'base_work_dir': '/builds/slave/test', 08:49:08 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:49:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:49:08 INFO - 'branch': 'Mozilla-Beta', 08:49:08 INFO - 'buildbot_json_path': 'buildprops.json', 08:49:08 INFO - 'config_files': ('talos/mac_config.py',), 08:49:08 INFO - 'default_actions': ('clobber', 08:49:08 INFO - 'read-buildbot-config', 08:49:08 INFO - 'download-and-extract', 08:49:08 INFO - 'populate-webroot', 08:49:08 INFO - 'create-virtualenv', 08:49:08 INFO - 'install', 08:49:08 INFO - 'run-tests'), 08:49:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:49:08 INFO - 'download_minidump_stackwalk': True, 08:49:08 INFO - 'download_symbols': 'ondemand', 08:49:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:49:08 INFO - 'tooltool.py': '/tools/tooltool.py', 08:49:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:49:08 INFO - '/tools/misc-python/virtualenv.py')}, 08:49:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:49:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:49:08 INFO - 'installer_path': 'installer.exe', 08:49:08 INFO - 'log_level': 'info', 08:49:08 INFO - 'log_name': 'talos', 08:49:08 INFO - 'log_to_console': True, 08:49:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:49:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:49:08 INFO - 'opt_config_files': (), 08:49:08 INFO - 'pip_index': False, 08:49:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:49:08 INFO - 'cmd': ('bash', 08:49:08 INFO - '-c', 08:49:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:49:08 INFO - 'enabled': True, 08:49:08 INFO - 'halt_on_failure': False, 08:49:08 INFO - 'name': 'check_screen_resolution'},), 08:49:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:49:08 INFO - 'cmd': ('bash', 08:49:08 INFO - '-c', 08:49:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:49:08 INFO - 'enabled': True, 08:49:08 INFO - 'halt_on_failure': False, 08:49:08 INFO - 'name': 'check_screen_resolution'},), 08:49:08 INFO - 'run_cmd_checks_enabled': True, 08:49:08 INFO - 'sps_profile': False, 08:49:08 INFO - 'sps_profile_interval': 0, 08:49:08 INFO - 'suite': 'dromaeojs-e10s', 08:49:08 INFO - 'system_bits': '32', 08:49:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:49:08 INFO - 'title': 't-yosemite-r7-0145', 08:49:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:49:08 INFO - 'use_talos_json': True, 08:49:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:49:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:49:08 INFO - 'work_dir': 'build'} 08:49:08 INFO - ##### 08:49:08 INFO - ##### Running clobber step. 08:49:08 INFO - ##### 08:49:08 INFO - Running pre-action listener: _resource_record_pre_action 08:49:08 INFO - Running main action method: clobber 08:49:08 INFO - rmtree: /builds/slave/test/build 08:49:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:49:10 INFO - Running post-action listener: _resource_record_post_action 08:49:10 INFO - ##### 08:49:10 INFO - ##### Running read-buildbot-config step. 08:49:10 INFO - ##### 08:49:10 INFO - Running pre-action listener: _resource_record_pre_action 08:49:10 INFO - Running main action method: read_buildbot_config 08:49:10 INFO - Using buildbot properties: 08:49:10 INFO - { 08:49:10 INFO - "project": "", 08:49:10 INFO - "product": "firefox", 08:49:10 INFO - "script_repo_revision": "production", 08:49:10 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 08:49:10 INFO - "repository": "", 08:49:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 08:49:10 INFO - "buildid": "20160726073802", 08:49:10 INFO - "pgo_build": "False", 08:49:10 INFO - "basedir": "/builds/slave/test", 08:49:10 INFO - "buildnumber": 56, 08:49:10 INFO - "slavename": "t-yosemite-r7-0145", 08:49:10 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 08:49:10 INFO - "platform": "yosemite_r7", 08:49:10 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:49:10 INFO - "branch": "mozilla-beta", 08:49:10 INFO - "repo_path": "releases/mozilla-beta", 08:49:10 INFO - "revision": "958cee08361af9ed370be06695973bcda3d3aa46", 08:49:10 INFO - "stage_platform": "macosx64", 08:49:10 INFO - "builduid": "6c72781d2b374e1f98a541c9c018fb4c", 08:49:10 INFO - "slavebuilddir": "test" 08:49:10 INFO - } 08:49:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 08:49:10 INFO - Running post-action listener: _resource_record_post_action 08:49:10 INFO - ##### 08:49:10 INFO - ##### Running download-and-extract step. 08:49:10 INFO - ##### 08:49:10 INFO - Running pre-action listener: _resource_record_pre_action 08:49:10 INFO - Running main action method: download_and_extract 08:49:10 INFO - mkdir: /builds/slave/test/build/tests 08:49: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:49:10 INFO - https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:49:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 08:49:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 08:49:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 08:49:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 08:49:15 INFO - Downloaded 1165 bytes. 08:49:15 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 08:49:15 INFO - Using the following test package requirements: 08:49:15 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 08:49:15 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:49:15 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 08:49:15 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:49:15 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 08:49:15 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:49:15 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:49:15 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 08:49:15 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 08:49:15 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:49:15 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 08:49:15 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:49:15 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 08:49:15 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:49:15 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 08:49:15 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:49:15 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 08:49:15 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 08:49: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:49:15 INFO - https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:49:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:49:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:49:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 08:49:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 08:49:17 INFO - Downloaded 18314870 bytes. 08:49:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:49:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:49:20 INFO - Return code: 0 08:49:20 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 08:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:20 INFO - https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:49:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:49:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:49:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 08:49:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 08:49:44 INFO - Downloaded 18314870 bytes. 08:49:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:49:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:49:47 INFO - Return code: 0 08:49: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:49:47 INFO - https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:49:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 08:49:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 08:49:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 08:49:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 08:49:48 INFO - Downloaded 10840145 bytes. 08:49:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:49:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 08:49:48 INFO - Return code: 0 08:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:48 INFO - https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 08:49:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:49:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:49:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 08:49:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 08:49:51 INFO - Downloaded 86255188 bytes. 08:49:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:49:51 INFO - mkdir: /builds/slave/test/properties 08:49:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:49:51 INFO - Writing to file /builds/slave/test/properties/build_url 08:49:51 INFO - Contents: 08:49:51 INFO - build_url:https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:49:52 INFO - Running post-action listener: _resource_record_post_action 08:49:52 INFO - Running post-action listener: set_extra_try_arguments 08:49:52 INFO - ##### 08:49:52 INFO - ##### Running populate-webroot step. 08:49:52 INFO - ##### 08:49:52 INFO - Running pre-action listener: _resource_record_pre_action 08:49:52 INFO - Running main action method: populate_webroot 08:49:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:49:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:49:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:49:52 INFO - '--tppagecycles', 08:49:52 INFO - '7'], 08:49:52 INFO - 'tests': ['tsvgm']}}, 08:49:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:49:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:49:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:49:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:49:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:49:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:49:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:52 INFO - 'talos_options': ['--disable-e10s'], 08:49:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:49:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:49:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:52 INFO - 'talos_options': ['--disable-e10s'], 08:49:52 INFO - 'tests': ['damp', 'tps']}, 08:49:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:52 INFO - 'tests': ['damp', 'tps']}, 08:49:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:49:52 INFO - 'tests': ['dromaeo_dom']}, 08:49:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:49:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:49:52 INFO - 'tests': ['a11yr', 08:49:52 INFO - 'ts_paint', 08:49:52 INFO - 'tpaint', 08:49:52 INFO - 'sessionrestore', 08:49:52 INFO - 'sessionrestore_no_auto_restore', 08:49:52 INFO - 'tabpaint']}, 08:49:52 INFO - 'other-e10s': {'tests': ['a11yr', 08:49:52 INFO - 'ts_paint', 08:49:52 INFO - 'tpaint', 08:49:52 INFO - 'sessionrestore', 08:49:52 INFO - 'sessionrestore_no_auto_restore', 08:49:52 INFO - 'tabpaint']}, 08:49:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:49:52 INFO - 'ts_paint', 08:49:52 INFO - 'tpaint', 08:49:52 INFO - 'sessionrestore', 08:49:52 INFO - 'sessionrestore_no_auto_restore', 08:49:52 INFO - 'tabpaint']}, 08:49:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:49:52 INFO - 'ts_paint', 08:49:52 INFO - 'tpaint', 08:49:52 INFO - 'sessionrestore', 08:49:52 INFO - 'sessionrestore_no_auto_restore', 08:49:52 INFO - 'tabpaint']}, 08:49:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:49:52 INFO - 'tests': ['a11yr', 08:49:52 INFO - 'ts_paint', 08:49:52 INFO - 'tpaint', 08:49:52 INFO - 'sessionrestore', 08:49:52 INFO - 'sessionrestore_no_auto_restore', 08:49:52 INFO - 'tabpaint']}, 08:49:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:49:52 INFO - 'tests': ['a11yr', 08:49:52 INFO - 'ts_paint', 08:49:52 INFO - 'tpaint', 08:49:52 INFO - 'sessionrestore', 08:49:52 INFO - 'sessionrestore_no_auto_restore', 08:49:52 INFO - 'tabpaint']}, 08:49:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:49:52 INFO - 'tests': ['tsvgx', 08:49:52 INFO - 'tsvgr_opacity', 08:49:52 INFO - 'tart', 08:49:52 INFO - 'tscrollx', 08:49:52 INFO - 'cart']}, 08:49:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:49:52 INFO - 'tsvgr_opacity', 08:49:52 INFO - 'tart', 08:49:52 INFO - 'tscrollx', 08:49:52 INFO - 'cart']}, 08:49:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:52 INFO - 'talos_options': ['--disable-e10s'], 08:49:52 INFO - 'tests': ['tp5o']}, 08:49:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:52 INFO - 'tests': ['tp5o']}, 08:49:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:52 INFO - 'talos_options': ['--disable-e10s', 08:49:52 INFO - '--xperf_path', 08:49:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:49:52 INFO - 'tests': ['tp5n']}, 08:49:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:49:52 INFO - 'talos_options': ['--xperf_path', 08:49:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:49:52 INFO - 'tests': ['tp5n']}}, 08:49:52 INFO - 'talos.zip': {'path': '', 08:49:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:49:52 INFO - Running post-action listener: _resource_record_post_action 08:49:52 INFO - ##### 08:49:52 INFO - ##### Running create-virtualenv step. 08:49:52 INFO - ##### 08:49:52 INFO - Running pre-action listener: _resource_record_pre_action 08:49:52 INFO - Running main action method: create_virtualenv 08:49:52 INFO - Creating virtualenv /builds/slave/test/build/venv 08:49:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:49:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:49:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:49:52 INFO - Using real prefix '/tools/python27' 08:49:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:49:53 INFO - Installing distribute.............................................................................................................................................................................................done. 08:49:56 INFO - Installing pip.................done. 08:49:56 INFO - Return code: 0 08:49:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:56 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 0x10a58ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a59b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc26bd7e740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a42ae00>, '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 0x10a293db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a425b20>, '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.rMZ3xf8UTn/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.5VKs5pjg1K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:49:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:49:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rMZ3xf8UTn/Render', 08:49:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:56 INFO - 'HOME': '/Users/cltbld', 08:49:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:56 INFO - 'LOGNAME': 'cltbld', 08:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:56 INFO - 'MOZ_NO_REMOTE': '1', 08:49:56 INFO - 'NO_EM_RESTART': '1', 08:49:56 INFO - 'PAGER': '/bin/cat', 08:49:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:56 INFO - 'PWD': '/builds/slave/test', 08:49:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:56 INFO - 'SHELL': '/bin/bash', 08:49:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5VKs5pjg1K/Listeners', 08:49:56 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 08:49:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:56 INFO - 'USER': 'cltbld', 08:49:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:56 INFO - 'XPC_FLAGS': '0x0', 08:49:56 INFO - 'XPC_SERVICE_NAME': '0', 08:49:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:49:56 INFO - Cleaning up... 08:49:56 INFO - Return code: 0 08:49:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:56 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 0x10a58ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a59b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc26bd7e740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a42ae00>, '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 0x10a293db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a425b20>, '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.rMZ3xf8UTn/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.5VKs5pjg1K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:49:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:49:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rMZ3xf8UTn/Render', 08:49:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:56 INFO - 'HOME': '/Users/cltbld', 08:49:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:56 INFO - 'LOGNAME': 'cltbld', 08:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:56 INFO - 'MOZ_NO_REMOTE': '1', 08:49:56 INFO - 'NO_EM_RESTART': '1', 08:49:56 INFO - 'PAGER': '/bin/cat', 08:49:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:56 INFO - 'PWD': '/builds/slave/test', 08:49:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:56 INFO - 'SHELL': '/bin/bash', 08:49:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5VKs5pjg1K/Listeners', 08:49:56 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 08:49:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:56 INFO - 'USER': 'cltbld', 08:49:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:56 INFO - 'XPC_FLAGS': '0x0', 08:49:56 INFO - 'XPC_SERVICE_NAME': '0', 08:49:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:56 INFO - Downloading/unpacking psutil>=0.7.1 08:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:49:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:49:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:49:59 INFO - Installing collected packages: psutil 08:49:59 INFO - Running setup.py install for psutil 08:49:59 INFO - building 'psutil._psutil_osx' extension 08:49:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:50:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:50:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:50:00 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:50:00 INFO - building 'psutil._psutil_posix' extension 08:50:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:50:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:50:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:50:00 INFO - ^ 08:50:00 INFO - 1 warning generated. 08:50:00 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:50:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:50:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:50:01 INFO - Successfully installed psutil 08:50:01 INFO - Cleaning up... 08:50:01 INFO - Return code: 0 08:50:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:01 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 0x10a58ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a59b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc26bd7e740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a42ae00>, '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 0x10a293db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a425b20>, '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.rMZ3xf8UTn/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.5VKs5pjg1K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:50:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:50:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:50:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rMZ3xf8UTn/Render', 08:50:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:01 INFO - 'HOME': '/Users/cltbld', 08:50:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:01 INFO - 'LOGNAME': 'cltbld', 08:50:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:01 INFO - 'MOZ_NO_REMOTE': '1', 08:50:01 INFO - 'NO_EM_RESTART': '1', 08:50:01 INFO - 'PAGER': '/bin/cat', 08:50:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:01 INFO - 'PWD': '/builds/slave/test', 08:50:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:01 INFO - 'SHELL': '/bin/bash', 08:50:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5VKs5pjg1K/Listeners', 08:50:01 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 08:50:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:01 INFO - 'USER': 'cltbld', 08:50:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:01 INFO - 'XPC_FLAGS': '0x0', 08:50:01 INFO - 'XPC_SERVICE_NAME': '0', 08:50:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:50:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:50:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:50:03 INFO - Installing collected packages: mozsystemmonitor 08:50:03 INFO - Running setup.py install for mozsystemmonitor 08:50:04 INFO - Successfully installed mozsystemmonitor 08:50:04 INFO - Cleaning up... 08:50:04 INFO - Return code: 0 08:50:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:50:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:04 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 0x10a58ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a59b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc26bd7e740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a42ae00>, '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 0x10a293db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a425b20>, '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.rMZ3xf8UTn/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.5VKs5pjg1K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:50:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:50:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:50:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rMZ3xf8UTn/Render', 08:50:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:04 INFO - 'HOME': '/Users/cltbld', 08:50:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:04 INFO - 'LOGNAME': 'cltbld', 08:50:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:04 INFO - 'MOZ_NO_REMOTE': '1', 08:50:04 INFO - 'NO_EM_RESTART': '1', 08:50:04 INFO - 'PAGER': '/bin/cat', 08:50:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:04 INFO - 'PWD': '/builds/slave/test', 08:50:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:04 INFO - 'SHELL': '/bin/bash', 08:50:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5VKs5pjg1K/Listeners', 08:50:04 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 08:50:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:04 INFO - 'USER': 'cltbld', 08:50:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:04 INFO - 'XPC_FLAGS': '0x0', 08:50:04 INFO - 'XPC_SERVICE_NAME': '0', 08:50:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:04 INFO - Downloading/unpacking blobuploader==1.2.4 08:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:07 INFO - Downloading blobuploader-1.2.4.tar.gz 08:50:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:50:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:50:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:08 INFO - Downloading docopt-0.6.1.tar.gz 08:50:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:50:09 INFO - Installing collected packages: blobuploader, requests, docopt 08:50:09 INFO - Running setup.py install for blobuploader 08:50:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:50:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:50:09 INFO - Running setup.py install for requests 08:50:09 INFO - Running setup.py install for docopt 08:50:09 INFO - Successfully installed blobuploader requests docopt 08:50:09 INFO - Cleaning up... 08:50:09 INFO - Return code: 0 08:50:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:09 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 0x10a58ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a59b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc26bd7e740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a42ae00>, '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 0x10a293db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a425b20>, '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.rMZ3xf8UTn/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.5VKs5pjg1K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:50:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:50:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:50:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rMZ3xf8UTn/Render', 08:50:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:09 INFO - 'HOME': '/Users/cltbld', 08:50:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:09 INFO - 'LOGNAME': 'cltbld', 08:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:09 INFO - 'MOZ_NO_REMOTE': '1', 08:50:09 INFO - 'NO_EM_RESTART': '1', 08:50:09 INFO - 'PAGER': '/bin/cat', 08:50:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:09 INFO - 'PWD': '/builds/slave/test', 08:50:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:09 INFO - 'SHELL': '/bin/bash', 08:50:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5VKs5pjg1K/Listeners', 08:50:09 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 08:50:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:09 INFO - 'USER': 'cltbld', 08:50:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:09 INFO - 'XPC_FLAGS': '0x0', 08:50:09 INFO - 'XPC_SERVICE_NAME': '0', 08:50:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:50:10 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-6dRxh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:50:10 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-nYVtbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:50:10 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-xLvTB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:50:10 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-mIl1Ff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:50:10 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-Vttu_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:50:10 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-xc8cUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:50:10 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-3Dyk1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:50:10 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-zonNS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:50:10 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-B7iope-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:50:11 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-47hUUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:50:11 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-2kJXpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:50:11 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-vLmhE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:50:11 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-R1jNZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:50:11 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-wg153y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:11 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-syl1Bi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:50:11 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-2n_PgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:50:11 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-IUsnJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:50:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:50:11 INFO - Running setup.py install for manifestparser 08:50:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:50:12 INFO - Running setup.py install for mozcrash 08:50:12 INFO - Running setup.py install for mozdebug 08:50:12 INFO - Running setup.py install for mozdevice 08:50:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:50:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:50:12 INFO - Running setup.py install for mozfile 08:50:12 INFO - Running setup.py install for mozhttpd 08:50:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:50:12 INFO - Running setup.py install for mozinfo 08:50:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:50:12 INFO - Running setup.py install for mozInstall 08:50:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:50:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:50:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:50:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:50:13 INFO - Running setup.py install for mozleak 08:50:13 INFO - Running setup.py install for mozlog 08:50:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:50:13 INFO - Running setup.py install for moznetwork 08:50:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:50:13 INFO - Running setup.py install for mozprocess 08:50:13 INFO - Running setup.py install for mozprofile 08:50:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:50:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:50:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:50:13 INFO - Running setup.py install for mozrunner 08:50:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:50:14 INFO - Running setup.py install for mozscreenshot 08:50:14 INFO - Running setup.py install for moztest 08:50:14 INFO - Running setup.py install for mozversion 08:50:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:50:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:50:14 INFO - Cleaning up... 08:50:14 INFO - Return code: 0 08:50:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:14 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 0x10a58ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a59b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc26bd7e740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a42ae00>, '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 0x10a293db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a425b20>, '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.rMZ3xf8UTn/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.5VKs5pjg1K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:50:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:50:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:50:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rMZ3xf8UTn/Render', 08:50:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:14 INFO - 'HOME': '/Users/cltbld', 08:50:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:14 INFO - 'LOGNAME': 'cltbld', 08:50:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:14 INFO - 'MOZ_NO_REMOTE': '1', 08:50:14 INFO - 'NO_EM_RESTART': '1', 08:50:14 INFO - 'PAGER': '/bin/cat', 08:50:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:14 INFO - 'PWD': '/builds/slave/test', 08:50:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:14 INFO - 'SHELL': '/bin/bash', 08:50:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5VKs5pjg1K/Listeners', 08:50:14 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 08:50:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:14 INFO - 'USER': 'cltbld', 08:50:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:14 INFO - 'XPC_FLAGS': '0x0', 08:50:14 INFO - 'XPC_SERVICE_NAME': '0', 08:50:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:50:14 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-87eQR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:50:14 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-LXLj9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:50:14 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-pRKRlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:50:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:50:15 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-lp9Wum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:50:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:50:15 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-43XTx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:50:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:50:15 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-fun_lt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:50:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:50:15 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-tIyphY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:50:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:50:15 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-KncnXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:50:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:50:15 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-Ya_vPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:50:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:50:15 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-95w1M0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:50:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:50:15 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-baT_mQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:50:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:50:15 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-o6qTgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:50:16 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-MFJnug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:50:16 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-51zLXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:16 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-ZecD3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:50:16 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-C0Vv2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:50:16 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-exfk5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:50:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:19 INFO - Downloading blessings-1.6.tar.gz 08:50:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:50:19 INFO - Installing collected packages: blessings 08:50:19 INFO - Running setup.py install for blessings 08:50:19 INFO - Successfully installed blessings 08:50:19 INFO - Cleaning up... 08:50:19 INFO - Return code: 0 08:50:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:50:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:50:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:50:19 INFO - Reading from file tmpfile_stdout 08:50:19 INFO - Current package versions: 08:50:19 INFO - blessings == 1.6 08:50:19 INFO - blobuploader == 1.2.4 08:50:19 INFO - docopt == 0.6.1 08:50:19 INFO - manifestparser == 1.1 08:50:19 INFO - mozInstall == 1.12 08:50:19 INFO - mozcrash == 0.17 08:50:20 INFO - mozdebug == 0.1 08:50:20 INFO - mozdevice == 0.48 08:50:20 INFO - mozfile == 1.2 08:50:20 INFO - mozhttpd == 0.7 08:50:20 INFO - mozinfo == 0.9 08:50:20 INFO - mozleak == 0.1 08:50:20 INFO - mozlog == 3.1 08:50:20 INFO - moznetwork == 0.27 08:50:20 INFO - mozprocess == 0.22 08:50:20 INFO - mozprofile == 0.28 08:50:20 INFO - mozrunner == 6.11 08:50:20 INFO - mozscreenshot == 0.1 08:50:20 INFO - mozsystemmonitor == 0.0 08:50:20 INFO - moztest == 0.7 08:50:20 INFO - mozversion == 1.4 08:50:20 INFO - psutil == 3.1.1 08:50:20 INFO - requests == 1.2.3 08:50:20 INFO - wsgiref == 0.1.2 08:50:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:20 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 0x10a58ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a59b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc26bd7e740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a42ae00>, '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 0x10a293db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a425b20>, '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.rMZ3xf8UTn/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.5VKs5pjg1K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:50:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:50:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:50:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rMZ3xf8UTn/Render', 08:50:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:20 INFO - 'HOME': '/Users/cltbld', 08:50:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:20 INFO - 'LOGNAME': 'cltbld', 08:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:20 INFO - 'MOZ_NO_REMOTE': '1', 08:50:20 INFO - 'NO_EM_RESTART': '1', 08:50:20 INFO - 'PAGER': '/bin/cat', 08:50:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:20 INFO - 'PWD': '/builds/slave/test', 08:50:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:20 INFO - 'SHELL': '/bin/bash', 08:50:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5VKs5pjg1K/Listeners', 08:50:20 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 08:50:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:20 INFO - 'USER': 'cltbld', 08:50:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:20 INFO - 'XPC_FLAGS': '0x0', 08:50:20 INFO - 'XPC_SERVICE_NAME': '0', 08:50:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:50:20 INFO - Cleaning up... 08:50:20 INFO - Return code: 0 08:50:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:20 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 0x10a58ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a59b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc26bd7e740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a42ae00>, '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 0x10a293db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a425b20>, '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.rMZ3xf8UTn/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.5VKs5pjg1K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:50:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:50:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:50:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rMZ3xf8UTn/Render', 08:50:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:20 INFO - 'HOME': '/Users/cltbld', 08:50:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:20 INFO - 'LOGNAME': 'cltbld', 08:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:20 INFO - 'MOZ_NO_REMOTE': '1', 08:50:20 INFO - 'NO_EM_RESTART': '1', 08:50:20 INFO - 'PAGER': '/bin/cat', 08:50:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:20 INFO - 'PWD': '/builds/slave/test', 08:50:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:20 INFO - 'SHELL': '/bin/bash', 08:50:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5VKs5pjg1K/Listeners', 08:50:20 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 08:50:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:20 INFO - 'USER': 'cltbld', 08:50:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:20 INFO - 'XPC_FLAGS': '0x0', 08:50:20 INFO - 'XPC_SERVICE_NAME': '0', 08:50:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:20 INFO - Downloading/unpacking jsonschema 08:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:50:22 INFO - Downloading/unpacking functools32 (from jsonschema) 08:50:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:23 INFO - Downloading functools32-3.2.3-2.tar.gz 08:50:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:50:23 INFO - warning: no files found matching '*.txt' 08:50:23 INFO - no previously-included directories found matching 'build' 08:50:23 INFO - no previously-included directories found matching 'dist' 08:50:23 INFO - no previously-included directories found matching '.git*' 08:50:23 INFO - Installing collected packages: jsonschema, functools32 08:50:23 INFO - Running setup.py install for functools32 08:50:23 INFO - warning: no files found matching '*.txt' 08:50:23 INFO - no previously-included directories found matching 'build' 08:50:23 INFO - no previously-included directories found matching 'dist' 08:50:23 INFO - no previously-included directories found matching '.git*' 08:50:23 INFO - Successfully installed jsonschema functools32 08:50:23 INFO - Cleaning up... 08:50:23 INFO - Return code: 0 08:50:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:50: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:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50: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:50:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:23 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 0x10a58ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a59b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc26bd7e740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a42ae00>, '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 0x10a293db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a425b20>, '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.rMZ3xf8UTn/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.5VKs5pjg1K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:50:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:50:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:50:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rMZ3xf8UTn/Render', 08:50:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:23 INFO - 'HOME': '/Users/cltbld', 08:50:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:23 INFO - 'LOGNAME': 'cltbld', 08:50:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:23 INFO - 'MOZ_NO_REMOTE': '1', 08:50:23 INFO - 'NO_EM_RESTART': '1', 08:50:23 INFO - 'PAGER': '/bin/cat', 08:50:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:23 INFO - 'PWD': '/builds/slave/test', 08:50:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:23 INFO - 'SHELL': '/bin/bash', 08:50:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5VKs5pjg1K/Listeners', 08:50:23 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 08:50:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:23 INFO - 'USER': 'cltbld', 08:50:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:23 INFO - 'XPC_FLAGS': '0x0', 08:50:23 INFO - 'XPC_SERVICE_NAME': '0', 08:50:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:23 INFO - Downloading/unpacking flake8 08:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:50:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:50:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:50:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:50:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:50:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:50:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:50:27 INFO - no previously-included directories found matching 'docs/_build' 08:50:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:50:27 INFO - Running setup.py install for pep8 08:50:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:50:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:50:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:50:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:50:27 INFO - no previously-included directories found matching 'docs/_build' 08:50:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:50:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:50:27 INFO - Cleaning up... 08:50:28 INFO - Return code: 0 08:50:28 INFO - Running post-action listener: _resource_record_post_action 08:50:28 INFO - Running post-action listener: _start_resource_monitoring 08:50:28 INFO - Starting resource monitoring. 08:50:28 INFO - ##### 08:50:28 INFO - ##### Running install step. 08:50:28 INFO - ##### 08:50:28 INFO - Running pre-action listener: _resource_record_pre_action 08:50:28 INFO - Running main action method: install 08:50:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:50:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:50:28 INFO - Reading from file tmpfile_stdout 08:50:28 INFO - Detecting whether we're running mozinstall >=1.0... 08:50:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:50:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:50:28 INFO - Reading from file tmpfile_stdout 08:50:28 INFO - Output received: 08:50:28 INFO - Usage: mozinstall [options] installer 08:50:28 INFO - Options: 08:50:28 INFO - -h, --help show this help message and exit 08:50:28 INFO - -d DEST, --destination=DEST 08:50:28 INFO - Directory to install application into. [default: 08:50:28 INFO - "/builds/slave/test"] 08:50:28 INFO - --app=APP Application being installed. [default: firefox] 08:50:28 INFO - mkdir: /builds/slave/test/build/application 08:50:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:50:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 08:50:50 INFO - Reading from file tmpfile_stdout 08:50:50 INFO - Output received: 08:50:50 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:50:50 INFO - Running post-action listener: _resource_record_post_action 08:50:50 INFO - ##### 08:50:50 INFO - ##### Running run-tests step. 08:50:50 INFO - ##### 08:50:50 INFO - Running pre-action listener: _resource_record_pre_action 08:50:50 INFO - Running main action method: run_tests 08:50:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:50:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:50:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:50:50 INFO - 2016-07-26 08:50:50.502 screenresolution[1640:7740] starting screenresolution argv=screenresolution get 08:50:50 INFO - 2016-07-26 08:50:50.504 screenresolution[1640:7740] Display 0: 1600x1200x32@60 08:50:50 INFO - 2016-07-26 08:50:50.510 screenresolution[1641:7742] starting screenresolution argv=screenresolution list 08:50:50 INFO - Available Modes on Display 0 08:50:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:50:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:50:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:50:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:50:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:50:50 INFO - Intel Iris: 08:50:50 INFO - Chipset Model: Intel Iris 08:50:50 INFO - Type: GPU 08:50:50 INFO - Bus: Built-In 08:50:50 INFO - VRAM (Dynamic, Max): 1536 MB 08:50:50 INFO - Vendor: Intel (0x8086) 08:50:50 INFO - Device ID: 0x0a2e 08:50:50 INFO - Revision ID: 0x0009 08:50:50 INFO - Displays: 08:50:50 INFO - Display: 08:50:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:50:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:50:50 INFO - Display Serial Number: 1600x1200 60 08:50:50 INFO - Main Display: Yes 08:50:50 INFO - Mirror: Off 08:50:50 INFO - Online: Yes 08:50:50 INFO - Rotation: Supported 08:50:50 INFO - Return code: 0 08:50:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:50:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:50:50 INFO - Python 2.7.3 08:50:50 INFO - Return code: 0 08:50:50 INFO - grabbing minidump binary from tooltool 08:50:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:50 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 0x10a42ae00>, '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 0x10a293db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a425b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:50:50 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:50:50 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:50:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:50:50 INFO - Return code: 0 08:50:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:50:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:50:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:50:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:50:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:50:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:50:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:50:51 INFO - Return code: 0 08:50:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0145', '--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:50:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0145 --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:50:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rMZ3xf8UTn/Render', 08:50:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:51 INFO - 'HOME': '/Users/cltbld', 08:50:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:51 INFO - 'LOGNAME': 'cltbld', 08:50:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:50:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:50:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:51 INFO - 'MOZ_NO_REMOTE': '1', 08:50:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:50:51 INFO - 'NO_EM_RESTART': '1', 08:50:51 INFO - 'PAGER': '/bin/cat', 08:50:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:51 INFO - 'PWD': '/builds/slave/test', 08:50:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:50:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:51 INFO - 'SHELL': '/bin/bash', 08:50:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5VKs5pjg1K/Listeners', 08:50:51 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 08:50:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:51 INFO - 'USER': 'cltbld', 08:50:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:51 INFO - 'XPC_FLAGS': '0x0', 08:50:51 INFO - 'XPC_SERVICE_NAME': '0', 08:50:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0145', '--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:50:52 INFO - mozversion application_buildid: 20160726073802 08:50:52 INFO - mozversion application_changeset: 958cee08361af9ed370be06695973bcda3d3aa46 08:50:52 INFO - mozversion application_display_name: Firefox 08:50:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:50:52 INFO - mozversion application_name: Firefox 08:50:52 INFO - mozversion application_remotingname: firefox 08:50:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:50:52 INFO - mozversion application_vendor: Mozilla 08:50:52 INFO - mozversion application_version: 48.0 08:50:52 INFO - mozversion platform_buildid: 20160726073802 08:50:52 INFO - mozversion platform_changeset: 958cee08361af9ed370be06695973bcda3d3aa46 08:50:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:50:52 INFO - mozversion platform_version: 48.0 08:50:52 INFO - using testdate: 1469548252 08:50:52 INFO - actual date: 1469548252 08:50:52 INFO - starting webserver on 'localhost:49276' 08:50:52 INFO - SUITE-START | Running 2 tests 08:50:52 INFO - TEST-START | dromaeo_css 08:50:52 INFO - operating with platform_type : mac_ 08:50:52 INFO - Initialising browser for dromaeo_css test... 08:50:52 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/tmpSbEcXf/profile http://localhost:49276/getInfo.html) 08:50:55 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 08:50:55 INFO - PROCESS | 1659 | colorDepth:24 08:50:55 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 08:50:55 INFO - PROCESS | 1659 | __metrics 08:50:55 ERROR - PROCESS | 1659 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 08:50:55 INFO - TEST-INFO | 1659: exit 0 08:50:55 INFO - Browser initialized. 08:50:55 INFO - Running cycle 1/1 for dromaeo_css test... 08:50:55 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/tmpSbEcXf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:51:07 INFO - PROCESS | 1663 | RSS: Main: 171053056 08:51:07 INFO - PROCESS | 1663 | 08:51:57 INFO - PROCESS | 1663 | 1469548317323 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:54:08 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 08:54:09 INFO - PROCESS | 1663 | RSS: Main: 181592064 08:54:09 INFO - PROCESS | 1663 | 08:57:11 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 08:57:12 INFO - PROCESS | 1663 | RSS: Main: 192679936 08:57:12 INFO - PROCESS | 1663 | 09:00:13 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 09:00:14 INFO - PROCESS | 1663 | RSS: Main: 194646016 09:00:14 INFO - PROCESS | 1663 | 09:03:16 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 09:03:16 INFO - PROCESS | 1663 | RSS: Main: 198610944 09:03:16 INFO - PROCESS | 1663 | 09:06:19 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 09:06:20 INFO - PROCESS | 1663 | RSS: Main: 197734400 09:06:20 INFO - PROCESS | 1663 | 09:09:22 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 09:09:22 INFO - PROCESS | 1663 | RSS: Main: 202682368 09:09:22 INFO - PROCESS | 1663 | 09:09:22 INFO - PROCESS | 1663 | __start_tp_report 09:09:22 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 09:09:22 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 09:09:22 INFO - PROCESS | 1663 | |i|pagename|runs| 09:09:22 INFO - PROCESS | 1663 | |0;dojo.html;3064.5556394322825;3718.572364178117;3726.888193354199;3757.6993840492764;3790.601986791385;5984.611000284978;6002.3097343805475;6056.8485787855325;6121.66330851803;6155.8768824623485;5973;6125.111858780474;6175.228096487939;6189.38106189382;6196.659183744892;5451.945480545193;5482.314710661168;5557.166425036236;5574.414686457904;5603.047481928062;4575.93136102957;5450.31871016123;5539.058360078776;5542.584306177033;5680.517156041741;5548.223248745179;5549.77800887964;5551.139573366115;5561.332640083196;5565.276514053167;5004.224345226496;5108.897822043576;5479.808206712746;5522.66863988162;5536.723163841792;4350.8912277193;5465;5498.0653288940575;5520.392756796749;5543.362513310981;6149.78475753351;6158.6612736299485;6166.84582885427;6177.598456100339;6190.814275571695;5874.706264686749;6146.7233974471255;6308.463780578656;6381.7766378177;6431;5372.785088596452;6549.705263263117;6566.80299591013;6587.176602924635;6598.538102332838;4998;6240.937590624081;6270.592411493284;6273.9372606273355;6295.590786598902;5659;6537.771178008747;6620.073189753439;6658.933410665928;6681.465482761368;6347.1114044033875;6350.237971443364;6376.330485298977;6394.328595497499;6406.199225096863;6518.641474718936;6527.902081468782;6529.314421985718;6535.640539770358;6567;6276.372362763778;6334.398232167937;6346.587471814318;6391.041343798467;6406;6419.839504012437;6430.839229019312;6452.032195170762;6466.579672321284;6473.320301368382;5095.617828662865;5148.871278218;5186.299849520342;5215.869603259949;5252.264682944391;4578.9542104579195;4615.353850460938;4645.210314246586;4671.906561868744;4739.454962679267;6275.121482992385;6286.49708023357;6308.148399966038;6323.52573556985;6334.809955701337;5341.519263266325;6570.211574611078;6577.572457790228;6594.538382313288;6595.043718660767;4966.379202599675;6190.81427557174;6200.286966998763;6262.342454042351;6375.234971803413;5679.403662615366;5680.8863822723315;5687.658740475585;5698.430156984268;5714.200011998323;6548.47612191014;6792.21889482706;6838.7264509420065;6848.280930502325;6853.9314606853295;6477.805665830033;6519.967400162969;6523.67381630907;6556.934430655823;6573.901391479228;6771.45828333742;6780.966095169492;6787.253402125861;6787.728490860311;6849.1096157499205;6317.30509643948;6393.456556192776;6463.418292353711;6480.805575832544;6500.804975850732;6495.2855185928565;6559.639219842955;6569.441597464269;6590.736370545124;6641.900371494335;6344.333844946399;6355.078513615592;6362.45919096882;6367.745290188526;6395.968020159869;6116.5718399711595;6219.471344935731;6272.09054687077;6291.245050593958;6357.046443033397;4994.275830004702;6232.626042437469;6304.085907543472;6313.08460273267;6327.240731112296;6299.157688150329;6315.336889626523;6336.08126821599;6342.619442833445;6368.108464815023;6198.349173336735;6221.502279817513;6249.468795152463;6297.149884765498;6305.8108256752375 09:09:22 INFO - PROCESS | 1663 | |1;ext.html;523.2517499975035;527.5041461026635;579.6782785554016;587.5241054745657;591.5770224289632;32557.5116373254;38701.225975480476;39752;39779.60220397795;39805.203895922066;41186.7940660297;41308.17383652325;41659.79170104145;41912;41990.790046049726;9588;9850.162736167398;9852.753681157958;9865.901340986606;9905.257105717064;9708.02919708027;9848.90151098487;9892.703218903445;9895.455749933752;9910.008999100068;8712.303015758724;9821.803563928717;9886.604535818595;9910.702678919644;9913;9800.460974646392;9813.901860981407;9885.209183265322;9887.752806179868;9910;9653.082957119062;9719.854202186973;9796.216302695768;9820.067093626094;9824.361416507903;39376.80311598453;39708.602913971066;39785.20429591421;39801;39920.60079399198;3337.1657085728566;3361.126107212118;3443.724502039831;3507.982460087683;3524.8942531724088;26730.19809405721;26802.061927832434;27351.452970940667;27969.720302796915;28293.717062829313;2793.5669971154302;2796.4407118576364;2849.3731379096566;2862.8711707973193;2903.1871076098514;344212.9999999975;345420;346940;347958.26020869985;349278;37560.24879502449;38163.61836381656;47565.81085472822;64831.13766467534;64987;36989.81505092511;37014.629853701656;37069.25861482755;37226.62773372286;37351.62648373536;15666.843331566766;15850.682986340209;15878.364865405485;15878.841211587736;15890.602734931488;13212.141210821266;13255.867441325656;13265.137766045176;13266;13282.800757988638;8278.917210827814;8548.786280343042;8601.483910965362;8687.6524939003;8705.91294087051;3597.8201089945924;3615.403458429382;3620.4931309616672;3630.618785027534;3639.9818000909827;999.2156157416539;1051.794899994509;1128.4527004402858;1175.7589694112687;1234;25139.87430062838;30465.019773714637;30594;31006.68993310083;31204.843975779975;1134.4316407997765;1183.3609850680537;1185.17038073349;1193.976120477603;1272.4146892429585;15414.152221627917;15430.922845385701;15858;16015.839841601668;16938;600077;606308;610737;611343;615874;62548;62798.37201628017;62896.68551657212;63135.684321579014;63243.367566323745;1544.95365139046;1568.552962405709;1581.1066747287746;1582.4619629325855;1592.8805339599576;26083;30784.692153078184;30842.537361940038;30962.845185773927;31618.683813161573;53162.2025669623;53256;53311.733441332544;53850.19224711554;53911.19133212927;542048;545152;548959;550047;552562;26111.608325874746;27380.452390951672;27483.587746184225;27568;27846.86076569604;36619.45070823993;39304.01739956524;45002;45255.0948981012;45257.547424525335;35807.104822378606;37313;37429;37916.62083379131;38559.61440385672;31633.20916977094;37165.62834371622;37312.626873732;37682;37935.81032094822;37130.8143459281;38458;40006.1998760029;40096.1980760389;40363;30249;32559.34881302408;32569.674303257612;32654.51018234681;32764.344713106082;21181.598692333355;24746.5067085102;25182.874085629453;25382.61926071147;25988 09:09:22 INFO - PROCESS | 1663 | |2;jquery.html;414.1654566049411;416.1427459433567;416.69373010837046;422.65764730568236;427.02424958968743;21305.36083917481;21327.466813329673;22174.002169902353;23138.76861231387;23196.536069278605;21056.789432105674;21181.788182118213;21202.151913923462;21506.677399839016;21690.240841570547;5862.853428664285;6120.326764055951;6195.2255968004;6201.906971395432;6224.657643829588;4428.468583769952;6043.6675982820925;6155.907661385083;6484.708188131545;6812.3187681231975;6647.800565983004;6735.797926062226;6747.05541224229;6750.864982700343;6751.898721519181;5944.316403613597;6122.540809439265;6444.355564443542;6496.382843629824;6620.3710647488415;5768.250127483442;5821.67980761058;5825.7087145642545;5826.329972053183;5828.242328497268;10719.892801071968;14262.786058209134;14308.499202527966;14334.713305733827;14366.784498232535;1980.6830907054803;2202.196198387593;2376.4415362389823;2431.8540887546806;2766.349907771672;9991.90008099917;10240.846387304196;10285.22860785444;10790.406527640976;10845.566177352897;1644.7335551625301;1840.3558754435974;1945.8929758863258;2016.1632922337212;2048.897555122238;102890.48554757178;112447.87552124455;112826;116274.41862790631;117313.65372692584;11933.04535637147;12425.19236249659;12466;12533.749325013448;12570.308633025272;15396.307166177548;15471.381144754308;15679.372825086868;15719.135447550267;15780.92109539445;8976.237019853255;9119.772005699779;9218.078192180863;9304.488253146143;9370.390924590016;8882.378233523721;9061.909380906238;9287.72136835896;9324.720258392259;9376.48429336393;4136.503619565671;4953.108440480748;5052.1663925451885;5059.139946209153;5073.492650734971;1810.3030333321503;1926.9807301927083;2037.94905127373;2111.841611879115;2140.6788981652876;949.8100379924043;953.547065144051;974.3569244298728;1020.9336393134422;1039.4387031003325;17715.29138834458;18061.638767224846;19317.22731090769;20796.58406831885;22271.44321391978;848.5036253791601;1028.095276156992;1028.5782829040058;1035.404642330663;1072.8498010278568;11359.545618175345;11561.595344162914;11575.13186511015;11675.94916457523;11699.473523691284;494102;499989;500480;564869;641403;128320.73434125248;138900.61099388875;140792.2960385212;144583;146034;992.3946392700446;1033.4109557552274;1036.3937096798456;1041.3647674918293;1059.3802625464036;19105.331313403964;19522;19799.109040092942;19955.60088798245;20110.798892011477;54278;56201.43798561962;56650.43349566452;56692.71653641705;57716;78816;79660;83609;85012;85655.57172214349;8303.584820758817;8336.374771892011;8477.830443391222;8631.6978905738;8814.735557933016;11541.480633371686;11742.412879356169;11792.646220613395;13185.406656700663;13193.802092968805;4456.888577785581;5306.681599104066;11354.148438866952;11359.659210223706;11532.94233528827;10701.357918524913;11173.441327933733;11264.605738799102;11379.943100284776;11399.601013964471;8718.517851965054;11214.271437137979;11774.646760597196;11809.996150327319;12075.456604452645;8670.82658346817;8691.838880555897;8740.388172827841;8857.070007649105;8994.460332380078;9442.763930901783;10780.730481738019;11762.647120586396;11845.644630661094;11968 09:09:22 INFO - PROCESS | 1663 | |3;mootools.html;1496.9101853888767;1619.7732317475557;1687.932482700692;2018.2431588154452;2042.9683010079925;7349.742759003436;7652.732154374591;8136.552489613069;9309.208717259024;9318.440893546383;9039.186473217409;9040;9087.545622718872;9185.173334399919;9203;2417.62526808345;2533.9737406350364;2542.186500319889;2544.5165418570414;2574.4336246025846;2483.8137139714595;2565.294544000396;2581.2643396631966;2588.5728854738945;2589.8575578343184;2537.708163561186;2566.538023155831;2570.3445621366527;2608.0610980047168;2611.073069060475;2560.590305551103;2561.602951542514;2579.9742002580015;2582.9612555811677;2597.324695579144;2526.4568117854565;2549.5665736824785;2556.348131226544;2588.365850366672;2597.844129352245;9243.6302547898;9280.814383712355;9284.953575232148;9290.442573445614;9292.488913109777;5605.607607467479;5720.1991721159075;5768.596198266123;5779.508741756956;5807.622504537191;3660.249648821985;3726.087108658396;3753.4369844523267;3754.342989976743;3779.6787273081823;1050.4642632257528;1060.730559498019;1070.427321383064;1089.7874914391696;1098.7033500954697;12002;12405.751884962341;12565.748685026248;12578.993680505537;12603.991680665526;5014.022265658235;5036.395632524121;5119.180931051088;5120.462351453119;5124.5131712487255;10190.388576685275;10375.688729338131;10394.688159355232;10420.843687344695;10426.739331516621;5673.801416950387;5700.7719691212715;5710.743016564182;5731.512821410143;5764.221830052889;4262.232798096373;4605.03294308199;5026.271190677331;5091.930694554185;5131.179011358239;4218.198542276958;4274.337477690963;4317.395564620955;4401.559844015637;4403.987082970934;1395.4836710417007;1414.087913295939;1427.2435609127178;1433.7634290342185;1434.5194359889554;904.5341649050744;947.2895328503622;972.3776782858976;980.152168374351;980.7499087732725;5897.52819774417;6101.938980610137;6116.724747386378;6167.6291649434925;6190.969045154746;978.8972157923315;979.5151400057017;1007.7480629842539;1022.1362948308667;1043.2227990147237;3936.566977632458;3961.227560625708;4005.8583303758287;4016.638502534786;4048.716589838683;10973.890261097447;11365;11528.711782205512;11642.88357116435;11707.707307317385;11320;11370.260933039492;11414.88585114155;11506.712332191762;11552.306861588331;8758.255548278341;8853.203211710977;8876.423032502867;8879.689210877588;8905.421147625384;5913.940860591339;6040.879182416415;6066.18106555627;6176.35148309421;6241.937580624136;10038.49807509607;10160.23798215122;10298.330608510423;10345.431001295;10391.844122338322;8902;9504.762380940256;9923.00769923002;10372.740681483023;10394.74013149647;7166.89249661266;7614.847703046019;7797.454178207471;7888.881666774888;7931.484453510503;7917.604119793872;8117.675292988451;8727.56362181901;8743.125687431206;8799.560021998746;7645.235476452311;7771.494852834548;7800.804979875548;7872.1340652529325;7875.330596899328;6968.024476573385;7351.3751331137455;7583.2416758323725;7719.498232614862;7846.097698764487;7342.596157211405;7354.043974283309;7354.411647068115;7380.704771809067;7383.372413344711;4968.503149685002;5059.797608095782;5206.453322401093;5226.660267082628;5299.41706412302;5069.417017043087;5098.719570423662;5162.948370516397;5167.431582525844;5274.393444753902 09:09:22 INFO - PROCESS | 1663 | |4;prototype.html;336.16295424393263;337.5207205767811;339.93031428557146;344.8258629392157;349.52988230829527;6935.341142591452;6995.860082798347;7026;7034.8944765828555;7038.718451261943;6904.171499420064;6917.396908504103;6942.583444993304;6962.408195303406;6994.825129371756;4882.707037577757;5014.172661510865;5111.182210846266;5111.463296353885;5126.871828204287;4121.814518346681;5012.949870501303;5055.3933527976515;5117.8464646060675;5148.2020286855595;4229.984803647118;5074.5432911038;5087.669301495391;5088.669236499634;5123.410807757118;5084;5095.745212739367;5111.4121875984365;5113.693178409308;5162.870928226825;3612.9277414451562;4407.030453300301;4416.624586910117;4419.270820314644;4454.33185022246;6352.460040896483;6649.501287403464;6687.063811066455;6739.157605299338;6750.392464678153;5866.413358664142;5936.910946335808;5945.632504523984;5947.583669143161;5958.880822383528;7418.814529636748;7457.9186018027085;7459.8508029839095;7468.962655186743;7490.438217133682;4747.216709242971;4759.833405830779;4762.833300834489;4775.355327030876;4779.498152693986;7595.202503737083;7826.373890088779;7906.090799558067;7910.485818421784;7970.362371010363;3971.801409929492;4742.624638854762;4747.192977193886;4808.9519104808505;4815.012922350909;4870.392770385764;4874.122657921537;4877.585405240523;4887.511248875155;4889.951100489021;5863.70681465925;5870.236869206976;5873.706314684248;5885.882282354329;5886.882262354815;7369.926300737031;7372.447066470037;7401.296876796696;7447.404207663374;7468.103827540621;1647.2258038721782;1681.9571865443504;1705.1985566783592;1710.2303963216602;1711.1102226841972;1073.0503504398664;1073.3238060022293;1082.7347299911414;1084.2247792828166;1089.455272363818;6740.955151951357;6901.585904845625;7113.608751518716;7139.428845692332;7174.354308112191;6918.515703900679;7403.14863790671;7624.618769061524;7701.922980770232;7719.382449404035;7170.713171473083;7211.963940180265;7217.603031833194;7238.348548630648;7244.565326080452;3653.05020694616;4097.016715988141;4125.1749650070105;4128.988397842548;4136.276151673445;7616.276453736997;8193.016837979481;8199.918000819915;8202.343812494986;8219.630116644765;6345.286772571472;7516.849663006818;8061.435699501096;8094.595270236582;8101.392395570356;8124.512529248264;8153.266206041485;8195.221453961864;8236;8236.629351679188;7768.184340644151;7800.024996875391;7819.569923654253;7819.726309579365;7864.016997875266;7652.61736913141;7659.846803064019;7663.233676632292;7666.156722760604;7680.654370553227;8031.638576264199;8247.917520824714;8250.216229458192;8266.13205613426;8305.418620696493;4302.290122129939;4939.061578300111;5064.518870707277;5086.64393492452;5088.59291256706;6170.629762214281;6676.631290585516;6901.378875901193;6954.374106330454;7693.692252309845;5957.434043765836;7207.603581802841;7408.777736667908;7434.888476672746;7467.253274672489;7339.302766237199;7361.631918403951;7446.994655721408;7459.776206713807;7471.907865797585;7181.856362872818;7214.531055481377;7230.819229519304;7253.057102576631;7260.128784545888;7401;7415.629218539159;7416.814579635552;7418.629068546659;7464.216257293123;7028.683709233199;7248.057752492142;7286.271372862671;7288.08898887639;7322.304381083789 09:09:22 INFO - PROCESS | 1663 | |5;yui.html;687.6527353686388;720.8594324106798;726.8800647893098;775.3254668438459;781.6365390093607;15438.91927565071;15582;15784.842151578496;15817.92091039546;15843.12862792546;13345.798878100968;14367;14616;14668.853311466883;14695.016172816666;774.4346626962321;897.0804924951912;953.7901661634464;968.9612415503371;972.6012334942675;952.2144231009411;963.6434519227895;965.7971825916566;966.0870477398861;969.9369540979849;1003.8945910679383;1021.0453226233458;1031.7575369788094;1033.0908800255802;1036.8341065429534;985.8570507276405;1004.9397036177853;1024.0680980307884;1030.814453398388;1030.8299130643472;757.325979877909;761.7866997240782;768.5158350239313;771.8417724366492;772.5866661336214;15006.849931500763;15050.849491505054;15147.772783408258;15348.462803801925;15442.922785386114;13217.933910330483;13266;13289.734205315935;13429.66425839352;13475.19148851072;8651.783705407415;10388.532516036796;10480.528376223088;10500.737481563023;10729.731756706067;3510.8420121094614;3547.592026916912;3552.91117722059;3632.2009157985467;3823.1589050408866;83732.74400883992;84109;84267.31465370658;84970.87572810668;85004;9731.659391921248;9801.705948821547;9819.705408837746;9993.150582200595;10161;19240.326588569333;21592.784072159076;22204.666929996063;22312.442188945406;22335.55328893413;7557.6221188940335;7580.317771400601;7592.050993625797;7639.923600764032;7741.1871753465075;4128.91742165161;4206.053637931441;4209.6000879916355;4217.40956266123;4231.640310573574;3578.7137029038136;3694.0210844126327;3755.342815007363;3762.209935913434;3775.9993601695573;665.411111166621;675.8513127112027;675.9459243260527;677.8271540757075;686.1594546680376;576.2681394628798;584.3100818332218;585.1047896718028;589.2781342854969;590.5924911810837;7234.312740289664;8057.073436554754;8213.589320533949;8217.01395832492;8460.576971151419;585.8798946216016;590.2268028882178;590.5452801342942;590.8463799412184;596.1147695671924;3789.6399842015517;3804.7907365094634;3819.2934307153264;3822.120912190156;4006.9198616027516;93010.53494732484;93504;93606.59590106018;95439;96487;83156;83723;84235.15764842396;84336;85094;69665.65167174132;69790;69920.30079699137;70170.64914675496;70539;7667.578283194478;7676;7685.615719214129;7736.690532378641;7792.961035195014;50979;51038.23442648438;51292.487075128774;51899;52595.21107183472;66698.99951500828;66814.66592667006;67423;67817.66091169513;68463.65768171127;9938.850917236103;9958.15355694774;9970.102690757867;10061.446620435947;10072.697819065439;10697.358158510515;10991.780164396507;11045.558177672803;11175.329480231212;11303.1522635801;10047.497625118569;10209.081182693593;10541.78916421652;10754.354738715389;10986.505607247853;9995.150412214753;10103.09072183507;10147.949260253652;10152.39085654863;10205.948970255102;9687.951560242154;9988.151007164182;9990.650327238513;10372.636957706443;10456.26806123564;8526.445781024213;8691.26124279418;8778.604962776562;8932.821343573221;9005.549722513717;6713.932860671331;8440.240378365976;8648.870266945874;8699.521526316114;8770.956145219234 09:09:22 INFO - PROCESS | 1663 | __end_tp_report 09:09:22 INFO - PROCESS | 1663 | __start_cc_report 09:09:22 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,397 09:09:22 INFO - PROCESS | 1663 | __end_cc_report 09:09:22 INFO - PROCESS | 1663 | __startTimestamp1469549362634__endTimestamp 09:09:22 INFO - PROCESS | 1663 | 09:09:22 INFO - PROCESS | 1663 | ------- Summary: start ------- 09:09:22 INFO - PROCESS | 1663 | Number of tests: 6 09:09:22 INFO - PROCESS | 1663 | 09:09:22 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:6007.71 Median:6276.37 stddev:695.84 (11.1%) stddev-sans-first:658.55 09:09:22 INFO - PROCESS | 1663 | Values: 3064.6 3718.6 3726.9 3757.7 3790.6 5984.6 6002.3 6056.8 6121.7 6155.9 5973.0 6125.1 6175.2 6189.4 6196.7 5451.9 5482.3 5557.2 5574.4 5603.0 4575.9 5450.3 5539.1 5542.6 5680.5 5548.2 5549.8 5551.1 5561.3 5565.3 5004.2 5108.9 5479.8 5522.7 5536.7 4350.9 5465.0 5498.1 5520.4 5543.4 6149.8 6158.7 6166.8 6177.6 6190.8 5874.7 6146.7 6308.5 6381.8 6431.0 5372.8 6549.7 6566.8 6587.2 6598.5 4998.0 6240.9 6270.6 6273.9 6295.6 5659.0 6537.8 6620.1 6658.9 6681.5 6347.1 6350.2 6376.3 6394.3 6406.2 6518.6 6527.9 6529.3 6535.6 6567.0 6276.4 6334.4 6346.6 6391.0 6406.0 6419.8 6430.8 6452.0 6466.6 6473.3 5095.6 5148.9 5186.3 5215.9 5252.3 4579.0 4615.4 4645.2 4671.9 4739.5 6275.1 6286.5 6308.1 6323.5 6334.8 5341.5 6570.2 6577.6 6594.5 6595.0 4966.4 6190.8 6200.3 6262.3 6375.2 5679.4 5680.9 5687.7 5698.4 5714.2 6548.5 6792.2 6838.7 6848.3 6853.9 6477.8 6520.0 6523.7 6556.9 6573.9 6771.5 6781.0 6787.3 6787.7 6849.1 6317.3 6393.5 6463.4 6480.8 6500.8 6495.3 6559.6 6569.4 6590.7 6641.9 6344.3 6355.1 6362.5 6367.7 6396.0 6116.6 6219.5 6272.1 6291.2 6357.0 4994.3 6232.6 6304.1 6313.1 6327.2 6299.2 6315.3 6336.1 6342.6 6368.1 6198.3 6221.5 6249.5 6297.1 6305.8 09:09:22 INFO - PROCESS | 1663 | 09:09:22 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:63061.79 Median:37332.31 stddev:137396.84 (368.0%) stddev-sans-first:137702.04 09:09:22 INFO - PROCESS | 1663 | Values: 523.3 527.5 579.7 587.5 591.6 32557.5 38701.2 39752.0 39779.6 39805.2 41186.8 41308.2 41659.8 41912.0 41990.8 9588.0 9850.2 9852.8 9865.9 9905.3 9708.0 9848.9 9892.7 9895.5 9910.0 8712.3 9821.8 9886.6 9910.7 9913.0 9800.5 9813.9 9885.2 9887.8 9910.0 9653.1 9719.9 9796.2 9820.1 9824.4 39376.8 39708.6 39785.2 39801.0 39920.6 3337.2 3361.1 3443.7 3508.0 3524.9 26730.2 26802.1 27351.5 27969.7 28293.7 2793.6 2796.4 2849.4 2862.9 2903.2 344213.0 345420.0 346940.0 347958.3 349278.0 37560.2 38163.6 47565.8 64831.1 64987.0 36989.8 37014.6 37069.3 37226.6 37351.6 15666.8 15850.7 15878.4 15878.8 15890.6 13212.1 13255.9 13265.1 13266.0 13282.8 8278.9 8548.8 8601.5 8687.7 8705.9 3597.8 3615.4 3620.5 3630.6 3640.0 999.2 1051.8 1128.5 1175.8 1234.0 25139.9 30465.0 30594.0 31006.7 31204.8 1134.4 1183.4 1185.2 1194.0 1272.4 15414.2 15430.9 15858.0 16015.8 16938.0 600077.0 606308.0 610737.0 611343.0 615874.0 62548.0 62798.4 62896.7 63135.7 63243.4 1545.0 1568.6 1581.1 1582.5 1592.9 26083.0 30784.7 30842.5 30962.8 31618.7 53162.2 53256.0 53311.7 53850.2 53911.2 542048.0 545152.0 548959.0 550047.0 552562.0 26111.6 27380.5 27483.6 27568.0 27846.9 36619.5 39304.0 45002.0 45255.1 45257.5 35807.1 37313.0 37429.0 37916.6 38559.6 31633.2 37165.6 37312.6 37682.0 37935.8 37130.8 38458.0 40006.2 40096.2 40363.0 30249.0 32559.3 32569.7 32654.5 32764.3 21181.6 24746.5 25182.9 25382.6 25988.0 09:09:22 INFO - PROCESS | 1663 | 09:09:22 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:33704.41 Median:21598.46 stddev:91548.82 (423.9%) stddev-sans-first:91771.51 09:09:22 INFO - PROCESS | 1663 | Values: 414.2 416.1 416.7 422.7 427.0 21305.4 21327.5 22174.0 23138.8 23196.5 21056.8 21181.8 21202.2 21506.7 21690.2 5862.9 6120.3 6195.2 6201.9 6224.7 4428.5 6043.7 6155.9 6484.7 6812.3 6647.8 6735.8 6747.1 6750.9 6751.9 5944.3 6122.5 6444.4 6496.4 6620.4 5768.3 5821.7 5825.7 5826.3 5828.2 10719.9 14262.8 14308.5 14334.7 14366.8 1980.7 2202.2 2376.4 2431.9 2766.3 9991.9 10240.8 10285.2 10790.4 10845.6 1644.7 1840.4 1945.9 2016.2 2048.9 102890.5 112447.9 112826.0 116274.4 117313.7 11933.0 12425.2 12466.0 12533.7 12570.3 15396.3 15471.4 15679.4 15719.1 15780.9 8976.2 9119.8 9218.1 9304.5 9370.4 8882.4 9061.9 9287.7 9324.7 9376.5 4136.5 4953.1 5052.2 5059.1 5073.5 1810.3 1927.0 2037.9 2111.8 2140.7 949.8 953.5 974.4 1020.9 1039.4 17715.3 18061.6 19317.2 20796.6 22271.4 848.5 1028.1 1028.6 1035.4 1072.8 11359.5 11561.6 11575.1 11675.9 11699.5 494102.0 499989.0 500480.0 564869.0 641403.0 128320.7 138900.6 140792.3 144583.0 146034.0 992.4 1033.4 1036.4 1041.4 1059.4 19105.3 19522.0 19799.1 19955.6 20110.8 54278.0 56201.4 56650.4 56692.7 57716.0 78816.0 79660.0 83609.0 85012.0 85655.6 8303.6 8336.4 8477.8 8631.7 8814.7 11541.5 11742.4 11792.6 13185.4 13193.8 4456.9 5306.7 11354.1 11359.7 11532.9 10701.4 11173.4 11264.6 11379.9 11399.6 8718.5 11214.3 11774.6 11810.0 12075.5 8670.8 8691.8 8740.4 8857.1 8994.5 9442.8 10780.7 11762.6 11845.6 11968.0 09:09:22 INFO - PROCESS | 1663 | 09:09:22 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:5973.85 Median:5048.10 stddev:3311.32 (65.6%) stddev-sans-first:3303.51 09:09:22 INFO - PROCESS | 1663 | Values: 1496.9 1619.8 1687.9 2018.2 2043.0 7349.7 7652.7 8136.6 9309.2 9318.4 9039.2 9040.0 9087.5 9185.2 9203.0 2417.6 2534.0 2542.2 2544.5 2574.4 2483.8 2565.3 2581.3 2588.6 2589.9 2537.7 2566.5 2570.3 2608.1 2611.1 2560.6 2561.6 2580.0 2583.0 2597.3 2526.5 2549.6 2556.3 2588.4 2597.8 9243.6 9280.8 9285.0 9290.4 9292.5 5605.6 5720.2 5768.6 5779.5 5807.6 3660.2 3726.1 3753.4 3754.3 3779.7 1050.5 1060.7 1070.4 1089.8 1098.7 12002.0 12405.8 12565.7 12579.0 12604.0 5014.0 5036.4 5119.2 5120.5 5124.5 10190.4 10375.7 10394.7 10420.8 10426.7 5673.8 5700.8 5710.7 5731.5 5764.2 4262.2 4605.0 5026.3 5091.9 5131.2 4218.2 4274.3 4317.4 4401.6 4404.0 1395.5 1414.1 1427.2 1433.8 1434.5 904.5 947.3 972.4 980.2 980.7 5897.5 6101.9 6116.7 6167.6 6191.0 978.9 979.5 1007.7 1022.1 1043.2 3936.6 3961.2 4005.9 4016.6 4048.7 10973.9 11365.0 11528.7 11642.9 11707.7 11320.0 11370.3 11414.9 11506.7 11552.3 8758.3 8853.2 8876.4 8879.7 8905.4 5913.9 6040.9 6066.2 6176.4 6241.9 10038.5 10160.2 10298.3 10345.4 10391.8 8902.0 9504.8 9923.0 10372.7 10394.7 7166.9 7614.8 7797.5 7888.9 7931.5 7917.6 8117.7 8727.6 8743.1 8799.6 7645.2 7771.5 7800.8 7872.1 7875.3 6968.0 7351.4 7583.2 7719.5 7846.1 7342.6 7354.0 7354.4 7380.7 7383.4 4968.5 5059.8 5206.5 5226.7 5299.4 5069.4 5098.7 5162.9 5167.4 5274.4 09:09:22 INFO - PROCESS | 1663 | 09:09:22 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:6061.71 Median:6938.96 stddev:1975.95 (28.5%) stddev-sans-first:1934.20 09:09:22 INFO - PROCESS | 1663 | Values: 336.2 337.5 339.9 344.8 349.5 6935.3 6995.9 7026.0 7034.9 7038.7 6904.2 6917.4 6942.6 6962.4 6994.8 4882.7 5014.2 5111.2 5111.5 5126.9 4121.8 5012.9 5055.4 5117.8 5148.2 4230.0 5074.5 5087.7 5088.7 5123.4 5084.0 5095.7 5111.4 5113.7 5162.9 3612.9 4407.0 4416.6 4419.3 4454.3 6352.5 6649.5 6687.1 6739.2 6750.4 5866.4 5936.9 5945.6 5947.6 5958.9 7418.8 7457.9 7459.9 7469.0 7490.4 4747.2 4759.8 4762.8 4775.4 4779.5 7595.2 7826.4 7906.1 7910.5 7970.4 3971.8 4742.6 4747.2 4809.0 4815.0 4870.4 4874.1 4877.6 4887.5 4890.0 5863.7 5870.2 5873.7 5885.9 5886.9 7369.9 7372.4 7401.3 7447.4 7468.1 1647.2 1682.0 1705.2 1710.2 1711.1 1073.1 1073.3 1082.7 1084.2 1089.5 6741.0 6901.6 7113.6 7139.4 7174.4 6918.5 7403.1 7624.6 7701.9 7719.4 7170.7 7212.0 7217.6 7238.3 7244.6 3653.1 4097.0 4125.2 4129.0 4136.3 7616.3 8193.0 8199.9 8202.3 8219.6 6345.3 7516.8 8061.4 8094.6 8101.4 8124.5 8153.3 8195.2 8236.0 8236.6 7768.2 7800.0 7819.6 7819.7 7864.0 7652.6 7659.8 7663.2 7666.2 7680.7 8031.6 8247.9 8250.2 8266.1 8305.4 4302.3 4939.1 5064.5 5086.6 5088.6 6170.6 6676.6 6901.4 6954.4 7693.7 5957.4 7207.6 7408.8 7434.9 7467.3 7339.3 7361.6 7447.0 7459.8 7471.9 7181.9 7214.5 7230.8 7253.1 7260.1 7401.0 7415.6 7416.8 7418.6 7464.2 7028.7 7248.1 7286.3 7288.1 7322.3 09:09:22 INFO - PROCESS | 1663 | 09:09:22 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:18526.21 Median:593.48 stddev:26599.31 (4481.9%) stddev-sans-first:26640.20 09:09:22 INFO - PROCESS | 1663 | Values: 687.7 720.9 726.9 775.3 781.6 15438.9 15582.0 15784.8 15817.9 15843.1 13345.8 14367.0 14616.0 14668.9 14695.0 774.4 897.1 953.8 969.0 972.6 952.2 963.6 965.8 966.1 969.9 1003.9 1021.0 1031.8 1033.1 1036.8 985.9 1004.9 1024.1 1030.8 1030.8 757.3 761.8 768.5 771.8 772.6 15006.8 15050.8 15147.8 15348.5 15442.9 13217.9 13266.0 13289.7 13429.7 13475.2 8651.8 10388.5 10480.5 10500.7 10729.7 3510.8 3547.6 3552.9 3632.2 3823.2 83732.7 84109.0 84267.3 84970.9 85004.0 9731.7 9801.7 9819.7 9993.2 10161.0 19240.3 21592.8 22204.7 22312.4 22335.6 7557.6 7580.3 7592.1 7639.9 7741.2 4128.9 4206.1 4209.6 4217.4 4231.6 3578.7 3694.0 3755.3 3762.2 3776.0 665.4 675.9 675.9 677.8 686.2 576.3 584.3 585.1 589.3 590.6 7234.3 8057.1 8213.6 8217.0 8460.6 585.9 590.2 590.5 590.8 596.1 3789.6 3804.8 3819.3 3822.1 4006.9 93010.5 93504.0 93606.6 95439.0 96487.0 83156.0 83723.0 84235.2 84336.0 85094.0 69665.7 69790.0 69920.3 70170.6 70539.0 7667.6 7676.0 7685.6 7736.7 7793.0 50979.0 51038.2 51292.5 51899.0 52595.2 66699.0 66814.7 67423.0 67817.7 68463.7 9938.9 9958.2 9970.1 10061.4 10072.7 10697.4 10991.8 11045.6 11175.3 11303.2 10047.5 10209.1 10541.8 10754.4 10986.5 9995.2 10103.1 10147.9 10152.4 10205.9 9688.0 9988.2 9990.7 10372.6 10456.3 8526.4 8691.3 8778.6 8932.8 9005.5 6713.9 8440.2 8648.9 8699.5 8771.0 09:09:22 INFO - PROCESS | 1663 | -------- Summary: end -------- 09:09:22 INFO - PROCESS | 1663 | 09:09:23 INFO - TEST-INFO | 1663: exit 0 09:09:23 INFO - TEST-OK | dromaeo_css | took 1111054ms 09:09:23 INFO - TEST-START | kraken 09:09:23 INFO - operating with platform_type : mac_ 09:09:23 INFO - Initialising browser for kraken test... 09:09:23 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/tmpuY5b9D/profile http://localhost:49276/getInfo.html) 09:09:25 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 09:09:25 INFO - PROCESS | 1671 | colorDepth:24 09:09:25 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 09:09:25 INFO - PROCESS | 1671 | __metrics 09:09:25 ERROR - PROCESS | 1671 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 09:09:26 INFO - TEST-INFO | 1671: exit 0 09:09:26 INFO - Browser initialized. 09:09:26 INFO - Running cycle 1/1 for kraken test... 09:09:26 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/tmpuY5b9D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:09:38 INFO - PROCESS | 1675 | RSS: Main: 170954752 09:09:38 INFO - PROCESS | 1675 | 09:09:40 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 09:09:41 INFO - PROCESS | 1675 | RSS: Main: 183238656 09:09:41 INFO - PROCESS | 1675 | 09:09:44 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 09:09:45 INFO - PROCESS | 1675 | RSS: Main: 191922176 09:09:45 INFO - PROCESS | 1675 | 09:09:48 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 09:09:49 INFO - PROCESS | 1675 | RSS: Main: 195387392 09:09:49 INFO - PROCESS | 1675 | 09:09:51 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 09:09:51 INFO - PROCESS | 1675 | RSS: Main: 196722688 09:09:51 INFO - PROCESS | 1675 | 09:09:53 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:09:54 INFO - PROCESS | 1675 | RSS: Main: 197001216 09:09:54 INFO - PROCESS | 1675 | 09:09:57 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 09:09:58 INFO - PROCESS | 1675 | RSS: Main: 197914624 09:09:58 INFO - PROCESS | 1675 | 09:10:00 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 09:10:01 INFO - PROCESS | 1675 | RSS: Main: 197959680 09:10:01 INFO - PROCESS | 1675 | 09:10:04 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 09:10:05 INFO - PROCESS | 1675 | RSS: Main: 198213632 09:10:05 INFO - PROCESS | 1675 | 09:10:06 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:10:07 INFO - PROCESS | 1675 | RSS: Main: 197312512 09:10:07 INFO - PROCESS | 1675 | 09:10:09 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:10:10 INFO - PROCESS | 1675 | RSS: Main: 197373952 09:10:10 INFO - PROCESS | 1675 | 09:10:12 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:10:12 INFO - PROCESS | 1675 | RSS: Main: 197632000 09:10:12 INFO - PROCESS | 1675 | 09:10:15 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:10:16 INFO - PROCESS | 1675 | RSS: Main: 197799936 09:10:16 INFO - PROCESS | 1675 | 09:10:19 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:10:19 INFO - PROCESS | 1675 | RSS: Main: 197722112 09:10:19 INFO - PROCESS | 1675 | 09:10:21 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 09:10:21 INFO - PROCESS | 1675 | RSS: Main: 199540736 09:10:21 INFO - PROCESS | 1675 | 09:10:21 INFO - PROCESS | 1675 | __start_tp_report 09:10:21 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 09:10:21 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 09:10:21 INFO - PROCESS | 1675 | |i|pagename|runs| 09:10:21 INFO - PROCESS | 1675 | |0;ai-astar;117;112;117;118;115;131;114;115;114;114 09:10:21 INFO - PROCESS | 1675 | |1;audio-beat-detection;151;114;141;162;148;138;149;174;149;140 09:10:21 INFO - PROCESS | 1675 | |2;audio-dft;276;270;195;197;194;203;195;209;239;196 09:10:21 INFO - PROCESS | 1675 | |3;audio-fft;66;77;74;139;57;56;58;64;129;86 09:10:21 INFO - PROCESS | 1675 | |4;audio-oscillator;81;82;121;76;77;83;117;77;80;123 09:10:21 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;89;92;88;96;85;128;108;85;119;127 09:10:21 INFO - PROCESS | 1675 | |6;imaging-darkroom;95;96;117;148;95;95;95;95;104;95 09:10:21 INFO - PROCESS | 1675 | |7;imaging-desaturate;111;129;90;116;142;145;115;91;118;144 09:10:21 INFO - PROCESS | 1675 | |8;json-parse-financial;60;60;62;65;64;63;65;79;62;59 09:10:21 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;62;66;64;72;67;96;96;56;84;94 09:10:21 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;81;83;81;80;83;80;80;84;84;85 09:10:21 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;125;124;132;148;135;154;142;146;175;145 09:10:21 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;165;164;169;166;172;171;211;211;161;165 09:10:21 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;67;63;98;95;95;94;68;68;66;70 09:10:21 INFO - PROCESS | 1675 | __end_tp_report 09:10:21 INFO - PROCESS | 1675 | __start_cc_report 09:10:21 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,1053 09:10:21 INFO - PROCESS | 1675 | __end_cc_report 09:10:21 INFO - PROCESS | 1675 | __startTimestamp1469549421767__endTimestamp 09:10:21 INFO - PROCESS | 1675 | 09:10:21 INFO - PROCESS | 1675 | ------- Summary: start ------- 09:10:21 INFO - PROCESS | 1675 | Number of tests: 14 09:10:21 INFO - PROCESS | 1675 | 09:10:21 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:116.70 Median:116.00 stddev:5.33 (4.6%) stddev-sans-first:5.66 09:10:21 INFO - PROCESS | 1675 | Values: 117.0 112.0 117.0 118.0 115.0 131.0 114.0 115.0 114.0 114.0 09:10:21 INFO - PROCESS | 1675 | 09:10:21 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:146.60 Median:149.00 stddev:15.75 (10.6%) stddev-sans-first:16.62 09:10:21 INFO - PROCESS | 1675 | Values: 151.0 114.0 141.0 162.0 148.0 138.0 149.0 174.0 149.0 140.0 09:10:21 INFO - PROCESS | 1675 | 09:10:21 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:217.40 Median:206.00 stddev:32.27 (15.7%) stddev-sans-first:26.35 09:10:21 INFO - PROCESS | 1675 | Values: 276.0 270.0 195.0 197.0 194.0 203.0 195.0 209.0 239.0 196.0 09:10:21 INFO - PROCESS | 1675 | 09:10:21 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:80.60 Median:65.00 stddev:29.81 (45.9%) stddev-sans-first:31.15 09:10:21 INFO - PROCESS | 1675 | Values: 66.0 77.0 74.0 139.0 57.0 56.0 58.0 64.0 129.0 86.0 09:10:21 INFO - PROCESS | 1675 | 09:10:21 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:78.50 stddev:19.94 (25.4%) stddev-sans-first:20.77 09:10:21 INFO - PROCESS | 1675 | Values: 81.0 82.0 121.0 76.0 77.0 83.0 117.0 77.0 80.0 123.0 09:10:21 INFO - PROCESS | 1675 | 09:10:21 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:101.70 Median:86.50 stddev:17.33 (20.0%) stddev-sans-first:17.77 09:10:21 INFO - PROCESS | 1675 | Values: 89.0 92.0 88.0 96.0 85.0 128.0 108.0 85.0 119.0 127.0 09:10:21 INFO - PROCESS | 1675 | 09:10:21 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:103.50 Median:95.00 stddev:17.17 (18.1%) stddev-sans-first:17.93 09:10:21 INFO - PROCESS | 1675 | Values: 95.0 96.0 117.0 148.0 95.0 95.0 95.0 95.0 104.0 95.0 09:10:21 INFO - PROCESS | 1675 | 09:10:21 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:120.10 Median:143.00 stddev:20.09 (14.0%) stddev-sans-first:21.04 09:10:21 INFO - PROCESS | 1675 | Values: 111.0 129.0 90.0 116.0 142.0 145.0 115.0 91.0 118.0 144.0 09:10:21 INFO - PROCESS | 1675 | 09:10:21 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:63.50 stddev:5.70 (9.0%) stddev-sans-first:5.87 09:10:21 INFO - PROCESS | 1675 | Values: 60.0 60.0 62.0 65.0 64.0 63.0 65.0 79.0 62.0 59.0 09:10:21 INFO - PROCESS | 1675 | 09:10:21 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:75.70 Median:78.00 stddev:15.36 (19.7%) stddev-sans-first:15.47 09:10:21 INFO - PROCESS | 1675 | Values: 62.0 66.0 64.0 72.0 67.0 96.0 96.0 56.0 84.0 94.0 09:10:21 INFO - PROCESS | 1675 | 09:10:21 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:83.00 stddev:1.91 (2.3%) stddev-sans-first:1.99 09:10:21 INFO - PROCESS | 1675 | Values: 81.0 83.0 81.0 80.0 83.0 80.0 80.0 84.0 84.0 85.0 09:10:21 INFO - PROCESS | 1675 | 09:10:21 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:142.60 Median:145.50 stddev:15.10 (10.4%) stddev-sans-first:14.61 09:10:21 INFO - PROCESS | 1675 | Values: 125.0 124.0 132.0 148.0 135.0 154.0 142.0 146.0 175.0 145.0 09:10:21 INFO - PROCESS | 1675 | 09:10:21 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.50 Median:170.00 stddev:19.00 (11.2%) stddev-sans-first:19.77 09:10:21 INFO - PROCESS | 1675 | Values: 165.0 164.0 169.0 166.0 172.0 171.0 211.0 211.0 161.0 165.0 09:10:21 INFO - PROCESS | 1675 | 09:10:21 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.40 Median:82.00 stddev:14.86 (18.1%) stddev-sans-first:15.17 09:10:21 INFO - PROCESS | 1675 | Values: 67.0 63.0 98.0 95.0 95.0 94.0 68.0 68.0 66.0 70.0 09:10:21 INFO - PROCESS | 1675 | -------- Summary: end -------- 09:10:21 INFO - PROCESS | 1675 | 09:10:22 INFO - TEST-INFO | 1675: exit 0 09:10:22 INFO - TEST-OK | kraken | took 59381ms 09:10:22 INFO - SUITE-END | took 1170s 09:10:22 INFO - Completed test suite (00:19:30) 09:10:22 INFO - javascript benchmark 09:10:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3064.5556394322825, 3718.572364178117, 3726.888193354199, 3757.6993840492764, 3790.601986791385, 5984.611000284978, 6002.3097343805475, 6056.8485787855325, 6121.66330851803, 6155.8768824623485, 5973.0, 6125.111858780474, 6175.228096487939, 6189.38106189382, 6196.659183744892, 5451.945480545193, 5482.314710661168, 5557.166425036236, 5574.414686457904, 5603.047481928062, 4575.93136102957, 5450.31871016123, 5539.058360078776, 5542.584306177033, 5680.517156041741, 5548.223248745179, 5549.77800887964, 5551.139573366115, 5561.332640083196, 5565.276514053167, 5004.224345226496, 5108.897822043576, 5479.808206712746, 5522.66863988162, 5536.723163841792, 4350.8912277193, 5465.0, 5498.0653288940575, 5520.392756796749, 5543.362513310981, 6149.78475753351, 6158.6612736299485, 6166.84582885427, 6177.598456100339, 6190.814275571695, 5874.706264686749, 6146.7233974471255, 6308.463780578656, 6381.7766378177, 6431.0, 5372.785088596452, 6549.705263263117, 6566.80299591013, 6587.176602924635, 6598.538102332838, 4998.0, 6240.937590624081, 6270.592411493284, 6273.9372606273355, 6295.590786598902, 5659.0, 6537.771178008747, 6620.073189753439, 6658.933410665928, 6681.465482761368, 6347.1114044033875, 6350.237971443364, 6376.330485298977, 6394.328595497499, 6406.199225096863, 6518.641474718936, 6527.902081468782, 6529.314421985718, 6535.640539770358, 6567.0, 6276.372362763778, 6334.398232167937, 6346.587471814318, 6391.041343798467, 6406.0, 6419.839504012437, 6430.839229019312, 6452.032195170762, 6466.579672321284, 6473.320301368382, 5095.617828662865, 5148.871278218, 5186.299849520342, 5215.869603259949, 5252.264682944391, 4578.9542104579195, 4615.353850460938, 4645.210314246586, 4671.906561868744, 4739.454962679267, 6275.121482992385, 6286.49708023357, 6308.148399966038, 6323.52573556985, 6334.809955701337, 5341.519263266325, 6570.211574611078, 6577.572457790228, 6594.538382313288, 6595.043718660767, 4966.379202599675, 6190.81427557174, 6200.286966998763, 6262.342454042351, 6375.234971803413, 5679.403662615366, 5680.8863822723315, 5687.658740475585, 5698.430156984268, 5714.200011998323, 6548.47612191014, 6792.21889482706, 6838.7264509420065, 6848.280930502325, 6853.9314606853295, 6477.805665830033, 6519.967400162969, 6523.67381630907, 6556.934430655823, 6573.901391479228, 6771.45828333742, 6780.966095169492, 6787.253402125861, 6787.728490860311, 6849.1096157499205, 6317.30509643948, 6393.456556192776, 6463.418292353711, 6480.805575832544, 6500.804975850732, 6495.2855185928565, 6559.639219842955, 6569.441597464269, 6590.736370545124, 6641.900371494335, 6344.333844946399, 6355.078513615592, 6362.45919096882, 6367.745290188526, 6395.968020159869, 6116.5718399711595, 6219.471344935731, 6272.09054687077, 6291.245050593958, 6357.046443033397, 4994.275830004702, 6232.626042437469, 6304.085907543472, 6313.08460273267, 6327.240731112296, 6299.157688150329, 6315.336889626523, 6336.08126821599, 6342.619442833445, 6368.108464815023, 6198.349173336735, 6221.502279817513, 6249.468795152463, 6297.149884765498, 6305.8108256752375], "value": 5966.4870953943855, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [523.2517499975035, 527.5041461026635, 579.6782785554016, 587.5241054745657, 591.5770224289632, 32557.5116373254, 38701.225975480476, 39752.0, 39779.60220397795, 39805.203895922066, 41186.7940660297, 41308.17383652325, 41659.79170104145, 41912.0, 41990.790046049726, 9588.0, 9850.162736167398, 9852.753681157958, 9865.901340986606, 9905.257105717064, 9708.02919708027, 9848.90151098487, 9892.703218903445, 9895.455749933752, 9910.008999100068, 8712.303015758724, 9821.803563928717, 9886.604535818595, 9910.702678919644, 9913.0, 9800.460974646392, 9813.901860981407, 9885.209183265322, 9887.752806179868, 9910.0, 9653.082957119062, 9719.854202186973, 9796.216302695768, 9820.067093626094, 9824.361416507903, 39376.80311598453, 39708.602913971066, 39785.20429591421, 39801.0, 39920.60079399198, 3337.1657085728566, 3361.126107212118, 3443.724502039831, 3507.982460087683, 3524.8942531724088, 26730.19809405721, 26802.061927832434, 27351.452970940667, 27969.720302796915, 28293.717062829313, 2793.5669971154302, 2796.4407118576364, 2849.3731379096566, 2862.8711707973193, 2903.1871076098514, 344212.9999999975, 345420.0, 346940.0, 347958.26020869985, 349278.0, 37560.24879502449, 38163.61836381656, 47565.81085472822, 64831.13766467534, 64987.0, 36989.81505092511, 37014.629853701656, 37069.25861482755, 37226.62773372286, 37351.62648373536, 15666.843331566766, 15850.682986340209, 15878.364865405485, 15878.841211587736, 15890.602734931488, 13212.141210821266, 13255.867441325656, 13265.137766045176, 13266.0, 13282.800757988638, 8278.917210827814, 8548.786280343042, 8601.483910965362, 8687.6524939003, 8705.91294087051, 3597.8201089945924, 3615.403458429382, 3620.4931309616672, 3630.618785027534, 3639.9818000909827, 999.2156157416539, 1051.794899994509, 1128.4527004402858, 1175.7589694112687, 1234.0, 25139.87430062838, 30465.019773714637, 30594.0, 31006.68993310083, 31204.843975779975, 1134.4316407997765, 1183.3609850680537, 1185.17038073349, 1193.976120477603, 1272.4146892429585, 15414.152221627917, 15430.922845385701, 15858.0, 16015.839841601668, 16938.0, 600077.0, 606308.0, 610737.0, 611343.0, 615874.0, 62548.0, 62798.37201628017, 62896.68551657212, 63135.684321579014, 63243.367566323745, 1544.95365139046, 1568.552962405709, 1581.1066747287746, 1582.4619629325855, 1592.8805339599576, 26083.0, 30784.692153078184, 30842.537361940038, 30962.845185773927, 31618.683813161573, 53162.2025669623, 53256.0, 53311.733441332544, 53850.19224711554, 53911.19133212927, 542048.0, 545152.0, 548959.0, 550047.0, 552562.0, 26111.608325874746, 27380.452390951672, 27483.587746184225, 27568.0, 27846.86076569604, 36619.45070823993, 39304.01739956524, 45002.0, 45255.0948981012, 45257.547424525335, 35807.104822378606, 37313.0, 37429.0, 37916.62083379131, 38559.61440385672, 31633.20916977094, 37165.62834371622, 37312.626873732, 37682.0, 37935.81032094822, 37130.8143459281, 38458.0, 40006.1998760029, 40096.1980760389, 40363.0, 30249.0, 32559.34881302408, 32569.674303257612, 32654.51018234681, 32764.344713106082, 21181.598692333355, 24746.5067085102, 25182.874085629453, 25382.61926071147, 25988.0], "value": 18680.371820021774, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.1654566049411, 416.1427459433567, 416.69373010837046, 422.65764730568236, 427.02424958968743, 21305.36083917481, 21327.466813329673, 22174.002169902353, 23138.76861231387, 23196.536069278605, 21056.789432105674, 21181.788182118213, 21202.151913923462, 21506.677399839016, 21690.240841570547, 5862.853428664285, 6120.326764055951, 6195.2255968004, 6201.906971395432, 6224.657643829588, 4428.468583769952, 6043.6675982820925, 6155.907661385083, 6484.708188131545, 6812.3187681231975, 6647.800565983004, 6735.797926062226, 6747.05541224229, 6750.864982700343, 6751.898721519181, 5944.316403613597, 6122.540809439265, 6444.355564443542, 6496.382843629824, 6620.3710647488415, 5768.250127483442, 5821.67980761058, 5825.7087145642545, 5826.329972053183, 5828.242328497268, 10719.892801071968, 14262.786058209134, 14308.499202527966, 14334.713305733827, 14366.784498232535, 1980.6830907054803, 2202.196198387593, 2376.4415362389823, 2431.8540887546806, 2766.349907771672, 9991.90008099917, 10240.846387304196, 10285.22860785444, 10790.406527640976, 10845.566177352897, 1644.7335551625301, 1840.3558754435974, 1945.8929758863258, 2016.1632922337212, 2048.897555122238, 102890.48554757178, 112447.87552124455, 112826.0, 116274.41862790631, 117313.65372692584, 11933.04535637147, 12425.19236249659, 12466.0, 12533.749325013448, 12570.308633025272, 15396.307166177548, 15471.381144754308, 15679.372825086868, 15719.135447550267, 15780.92109539445, 8976.237019853255, 9119.772005699779, 9218.078192180863, 9304.488253146143, 9370.390924590016, 8882.378233523721, 9061.909380906238, 9287.72136835896, 9324.720258392259, 9376.48429336393, 4136.503619565671, 4953.108440480748, 5052.1663925451885, 5059.139946209153, 5073.492650734971, 1810.3030333321503, 1926.9807301927083, 2037.94905127373, 2111.841611879115, 2140.6788981652876, 949.8100379924043, 953.547065144051, 974.3569244298728, 1020.9336393134422, 1039.4387031003325, 17715.29138834458, 18061.638767224846, 19317.22731090769, 20796.58406831885, 22271.44321391978, 848.5036253791601, 1028.095276156992, 1028.5782829040058, 1035.404642330663, 1072.8498010278568, 11359.545618175345, 11561.595344162914, 11575.13186511015, 11675.94916457523, 11699.473523691284, 494102.0, 499989.0, 500480.0, 564869.0, 641403.0, 128320.73434125248, 138900.61099388875, 140792.2960385212, 144583.0, 146034.0, 992.3946392700446, 1033.4109557552274, 1036.3937096798456, 1041.3647674918293, 1059.3802625464036, 19105.331313403964, 19522.0, 19799.109040092942, 19955.60088798245, 20110.798892011477, 54278.0, 56201.43798561962, 56650.43349566452, 56692.71653641705, 57716.0, 78816.0, 79660.0, 83609.0, 85012.0, 85655.57172214349, 8303.584820758817, 8336.374771892011, 8477.830443391222, 8631.6978905738, 8814.735557933016, 11541.480633371686, 11742.412879356169, 11792.646220613395, 13185.406656700663, 13193.802092968805, 4456.888577785581, 5306.681599104066, 11354.148438866952, 11359.659210223706, 11532.94233528827, 10701.357918524913, 11173.441327933733, 11264.605738799102, 11379.943100284776, 11399.601013964471, 8718.517851965054, 11214.271437137979, 11774.646760597196, 11809.996150327319, 12075.456604452645, 8670.82658346817, 8691.838880555897, 8740.388172827841, 8857.070007649105, 8994.460332380078, 9442.763930901783, 10780.730481738019, 11762.647120586396, 11845.644630661094, 11968.0], "value": 9727.643302254435, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1496.9101853888767, 1619.7732317475557, 1687.932482700692, 2018.2431588154452, 2042.9683010079925, 7349.742759003436, 7652.732154374591, 8136.552489613069, 9309.208717259024, 9318.440893546383, 9039.186473217409, 9040.0, 9087.545622718872, 9185.173334399919, 9203.0, 2417.62526808345, 2533.9737406350364, 2542.186500319889, 2544.5165418570414, 2574.4336246025846, 2483.8137139714595, 2565.294544000396, 2581.2643396631966, 2588.5728854738945, 2589.8575578343184, 2537.708163561186, 2566.538023155831, 2570.3445621366527, 2608.0610980047168, 2611.073069060475, 2560.590305551103, 2561.602951542514, 2579.9742002580015, 2582.9612555811677, 2597.324695579144, 2526.4568117854565, 2549.5665736824785, 2556.348131226544, 2588.365850366672, 2597.844129352245, 9243.6302547898, 9280.814383712355, 9284.953575232148, 9290.442573445614, 9292.488913109777, 5605.607607467479, 5720.1991721159075, 5768.596198266123, 5779.508741756956, 5807.622504537191, 3660.249648821985, 3726.087108658396, 3753.4369844523267, 3754.342989976743, 3779.6787273081823, 1050.4642632257528, 1060.730559498019, 1070.427321383064, 1089.7874914391696, 1098.7033500954697, 12002.0, 12405.751884962341, 12565.748685026248, 12578.993680505537, 12603.991680665526, 5014.022265658235, 5036.395632524121, 5119.180931051088, 5120.462351453119, 5124.5131712487255, 10190.388576685275, 10375.688729338131, 10394.688159355232, 10420.843687344695, 10426.739331516621, 5673.801416950387, 5700.7719691212715, 5710.743016564182, 5731.512821410143, 5764.221830052889, 4262.232798096373, 4605.03294308199, 5026.271190677331, 5091.930694554185, 5131.179011358239, 4218.198542276958, 4274.337477690963, 4317.395564620955, 4401.559844015637, 4403.987082970934, 1395.4836710417007, 1414.087913295939, 1427.2435609127178, 1433.7634290342185, 1434.5194359889554, 904.5341649050744, 947.2895328503622, 972.3776782858976, 980.152168374351, 980.7499087732725, 5897.52819774417, 6101.938980610137, 6116.724747386378, 6167.6291649434925, 6190.969045154746, 978.8972157923315, 979.5151400057017, 1007.7480629842539, 1022.1362948308667, 1043.2227990147237, 3936.566977632458, 3961.227560625708, 4005.8583303758287, 4016.638502534786, 4048.716589838683, 10973.890261097447, 11365.0, 11528.711782205512, 11642.88357116435, 11707.707307317385, 11320.0, 11370.260933039492, 11414.88585114155, 11506.712332191762, 11552.306861588331, 8758.255548278341, 8853.203211710977, 8876.423032502867, 8879.689210877588, 8905.421147625384, 5913.940860591339, 6040.879182416415, 6066.18106555627, 6176.35148309421, 6241.937580624136, 10038.49807509607, 10160.23798215122, 10298.330608510423, 10345.431001295, 10391.844122338322, 8902.0, 9504.762380940256, 9923.00769923002, 10372.740681483023, 10394.74013149647, 7166.89249661266, 7614.847703046019, 7797.454178207471, 7888.881666774888, 7931.484453510503, 7917.604119793872, 8117.675292988451, 8727.56362181901, 8743.125687431206, 8799.560021998746, 7645.235476452311, 7771.494852834548, 7800.804979875548, 7872.1340652529325, 7875.330596899328, 6968.024476573385, 7351.3751331137455, 7583.2416758323725, 7719.498232614862, 7846.097698764487, 7342.596157211405, 7354.043974283309, 7354.411647068115, 7380.704771809067, 7383.372413344711, 4968.503149685002, 5059.797608095782, 5206.453322401093, 5226.660267082628, 5299.41706412302, 5069.417017043087, 5098.719570423662, 5162.948370516397, 5167.431582525844, 5274.393444753902], "value": 4835.145699334723, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.16295424393263, 337.5207205767811, 339.93031428557146, 344.8258629392157, 349.52988230829527, 6935.341142591452, 6995.860082798347, 7026.0, 7034.8944765828555, 7038.718451261943, 6904.171499420064, 6917.396908504103, 6942.583444993304, 6962.408195303406, 6994.825129371756, 4882.707037577757, 5014.172661510865, 5111.182210846266, 5111.463296353885, 5126.871828204287, 4121.814518346681, 5012.949870501303, 5055.3933527976515, 5117.8464646060675, 5148.2020286855595, 4229.984803647118, 5074.5432911038, 5087.669301495391, 5088.669236499634, 5123.410807757118, 5084.0, 5095.745212739367, 5111.4121875984365, 5113.693178409308, 5162.870928226825, 3612.9277414451562, 4407.030453300301, 4416.624586910117, 4419.270820314644, 4454.33185022246, 6352.460040896483, 6649.501287403464, 6687.063811066455, 6739.157605299338, 6750.392464678153, 5866.413358664142, 5936.910946335808, 5945.632504523984, 5947.583669143161, 5958.880822383528, 7418.814529636748, 7457.9186018027085, 7459.8508029839095, 7468.962655186743, 7490.438217133682, 4747.216709242971, 4759.833405830779, 4762.833300834489, 4775.355327030876, 4779.498152693986, 7595.202503737083, 7826.373890088779, 7906.090799558067, 7910.485818421784, 7970.362371010363, 3971.801409929492, 4742.624638854762, 4747.192977193886, 4808.9519104808505, 4815.012922350909, 4870.392770385764, 4874.122657921537, 4877.585405240523, 4887.511248875155, 4889.951100489021, 5863.70681465925, 5870.236869206976, 5873.706314684248, 5885.882282354329, 5886.882262354815, 7369.926300737031, 7372.447066470037, 7401.296876796696, 7447.404207663374, 7468.103827540621, 1647.2258038721782, 1681.9571865443504, 1705.1985566783592, 1710.2303963216602, 1711.1102226841972, 1073.0503504398664, 1073.3238060022293, 1082.7347299911414, 1084.2247792828166, 1089.455272363818, 6740.955151951357, 6901.585904845625, 7113.608751518716, 7139.428845692332, 7174.354308112191, 6918.515703900679, 7403.14863790671, 7624.618769061524, 7701.922980770232, 7719.382449404035, 7170.713171473083, 7211.963940180265, 7217.603031833194, 7238.348548630648, 7244.565326080452, 3653.05020694616, 4097.016715988141, 4125.1749650070105, 4128.988397842548, 4136.276151673445, 7616.276453736997, 8193.016837979481, 8199.918000819915, 8202.343812494986, 8219.630116644765, 6345.286772571472, 7516.849663006818, 8061.435699501096, 8094.595270236582, 8101.392395570356, 8124.512529248264, 8153.266206041485, 8195.221453961864, 8236.0, 8236.629351679188, 7768.184340644151, 7800.024996875391, 7819.569923654253, 7819.726309579365, 7864.016997875266, 7652.61736913141, 7659.846803064019, 7663.233676632292, 7666.156722760604, 7680.654370553227, 8031.638576264199, 8247.917520824714, 8250.216229458192, 8266.13205613426, 8305.418620696493, 4302.290122129939, 4939.061578300111, 5064.518870707277, 5086.64393492452, 5088.59291256706, 6170.629762214281, 6676.631290585516, 6901.378875901193, 6954.374106330454, 7693.692252309845, 5957.434043765836, 7207.603581802841, 7408.777736667908, 7434.888476672746, 7467.253274672489, 7339.302766237199, 7361.631918403951, 7446.994655721408, 7459.776206713807, 7471.907865797585, 7181.856362872818, 7214.531055481377, 7230.819229519304, 7253.057102576631, 7260.128784545888, 7401.0, 7415.629218539159, 7416.814579635552, 7418.629068546659, 7464.216257293123, 7028.683709233199, 7248.057752492142, 7286.271372862671, 7288.08898887639, 7322.304381083789], "value": 5396.040027084484, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.6527353686388, 720.8594324106798, 726.8800647893098, 775.3254668438459, 781.6365390093607, 15438.91927565071, 15582.0, 15784.842151578496, 15817.92091039546, 15843.12862792546, 13345.798878100968, 14367.0, 14616.0, 14668.853311466883, 14695.016172816666, 774.4346626962321, 897.0804924951912, 953.7901661634464, 968.9612415503371, 972.6012334942675, 952.2144231009411, 963.6434519227895, 965.7971825916566, 966.0870477398861, 969.9369540979849, 1003.8945910679383, 1021.0453226233458, 1031.7575369788094, 1033.0908800255802, 1036.8341065429534, 985.8570507276405, 1004.9397036177853, 1024.0680980307884, 1030.814453398388, 1030.8299130643472, 757.325979877909, 761.7866997240782, 768.5158350239313, 771.8417724366492, 772.5866661336214, 15006.849931500763, 15050.849491505054, 15147.772783408258, 15348.462803801925, 15442.922785386114, 13217.933910330483, 13266.0, 13289.734205315935, 13429.66425839352, 13475.19148851072, 8651.783705407415, 10388.532516036796, 10480.528376223088, 10500.737481563023, 10729.731756706067, 3510.8420121094614, 3547.592026916912, 3552.91117722059, 3632.2009157985467, 3823.1589050408866, 83732.74400883992, 84109.0, 84267.31465370658, 84970.87572810668, 85004.0, 9731.659391921248, 9801.705948821547, 9819.705408837746, 9993.150582200595, 10161.0, 19240.326588569333, 21592.784072159076, 22204.666929996063, 22312.442188945406, 22335.55328893413, 7557.6221188940335, 7580.317771400601, 7592.050993625797, 7639.923600764032, 7741.1871753465075, 4128.91742165161, 4206.053637931441, 4209.6000879916355, 4217.40956266123, 4231.640310573574, 3578.7137029038136, 3694.0210844126327, 3755.342815007363, 3762.209935913434, 3775.9993601695573, 665.411111166621, 675.8513127112027, 675.9459243260527, 677.8271540757075, 686.1594546680376, 576.2681394628798, 584.3100818332218, 585.1047896718028, 589.2781342854969, 590.5924911810837, 7234.312740289664, 8057.073436554754, 8213.589320533949, 8217.01395832492, 8460.576971151419, 585.8798946216016, 590.2268028882178, 590.5452801342942, 590.8463799412184, 596.1147695671924, 3789.6399842015517, 3804.7907365094634, 3819.2934307153264, 3822.120912190156, 4006.9198616027516, 93010.53494732484, 93504.0, 93606.59590106018, 95439.0, 96487.0, 83156.0, 83723.0, 84235.15764842396, 84336.0, 85094.0, 69665.65167174132, 69790.0, 69920.30079699137, 70170.64914675496, 70539.0, 7667.578283194478, 7676.0, 7685.615719214129, 7736.690532378641, 7792.961035195014, 50979.0, 51038.23442648438, 51292.487075128774, 51899.0, 52595.21107183472, 66698.99951500828, 66814.66592667006, 67423.0, 67817.66091169513, 68463.65768171127, 9938.850917236103, 9958.15355694774, 9970.102690757867, 10061.446620435947, 10072.697819065439, 10697.358158510515, 10991.780164396507, 11045.558177672803, 11175.329480231212, 11303.1522635801, 10047.497625118569, 10209.081182693593, 10541.78916421652, 10754.354738715389, 10986.505607247853, 9995.150412214753, 10103.09072183507, 10147.949260253652, 10152.39085654863, 10205.948970255102, 9687.951560242154, 9988.151007164182, 9990.650327238513, 10372.636957706443, 10456.26806123564, 8526.445781024213, 8691.26124279418, 8778.604962776562, 8932.821343573221, 9005.549722513717, 6713.932860671331, 8440.240378365976, 8648.870266945874, 8699.521526316114, 8770.956145219234], "value": 6918.164509196834, "unit": "score"}], "name": "dromaeo_css", "value": 7619.676642513495, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 112.0, 117.0, 118.0, 115.0, 131.0, 114.0, 115.0, 114.0, 114.0], "value": 116.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 114.0, 141.0, 162.0, 148.0, 138.0, 149.0, 174.0, 149.0, 140.0], "value": 146.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [276.0, 270.0, 195.0, 197.0, 194.0, 203.0, 195.0, 209.0, 239.0, 196.0], "value": 217.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 77.0, 74.0, 139.0, 57.0, 56.0, 58.0, 64.0, 129.0, 86.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 121.0, 76.0, 77.0, 83.0, 117.0, 77.0, 80.0, 123.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 88.0, 96.0, 85.0, 128.0, 108.0, 85.0, 119.0, 127.0], "value": 101.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 117.0, 148.0, 95.0, 95.0, 95.0, 95.0, 104.0, 95.0], "value": 103.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 129.0, 90.0, 116.0, 142.0, 145.0, 115.0, 91.0, 118.0, 144.0], "value": 120.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 62.0, 65.0, 64.0, 63.0, 65.0, 79.0, 62.0, 59.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 66.0, 64.0, 72.0, 67.0, 96.0, 96.0, 56.0, 84.0, 94.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 81.0, 80.0, 83.0, 80.0, 80.0, 84.0, 84.0, 85.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 124.0, 132.0, 148.0, 135.0, 154.0, 142.0, 146.0, 175.0, 145.0], "value": 142.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 169.0, 166.0, 172.0, 171.0, 211.0, 211.0, 161.0, 165.0], "value": 175.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 98.0, 95.0, 95.0, 94.0, 68.0, 68.0, 66.0, 70.0], "value": 78.4, "unit": "score"}], "name": "kraken", "value": 1596.5000000000002, "alertThreshold": 2.0}]} 09:10:23 INFO - Return code: 0 09:10:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:10:23 ERROR - # TBPL SUCCESS # 09:10:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:10:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:10:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:10:23 INFO - 2016-07-26 09:10:23.097 screenresolution[1680:10732] starting screenresolution argv=screenresolution get 09:10:23 INFO - 2016-07-26 09:10:23.100 screenresolution[1680:10732] Display 0: 1600x1200x32@60 09:10:23 INFO - 2016-07-26 09:10:23.105 screenresolution[1681:10735] starting screenresolution argv=screenresolution list 09:10:23 INFO - Available Modes on Display 0 09:10:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:10:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:10:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:10:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:10:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:10:23 INFO - Intel Iris: 09:10:23 INFO - Chipset Model: Intel Iris 09:10:23 INFO - Type: GPU 09:10:23 INFO - Bus: Built-In 09:10:23 INFO - VRAM (Dynamic, Max): 1536 MB 09:10:23 INFO - Vendor: Intel (0x8086) 09:10:23 INFO - Device ID: 0x0a2e 09:10:23 INFO - Revision ID: 0x0009 09:10:23 INFO - Displays: 09:10:23 INFO - Display: 09:10:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:10:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:10:23 INFO - Display Serial Number: 1600x1200 60 09:10:23 INFO - Main Display: Yes 09:10:23 INFO - Mirror: Off 09:10:23 INFO - Online: Yes 09:10:23 INFO - Rotation: Supported 09:10:23 INFO - Return code: 0 09:10:23 INFO - Running post-action listener: _resource_record_post_action 09:10:23 INFO - Running post-run listener: _resource_record_post_run 09:10:24 INFO - Total resource usage - Wall time: 1194s; CPU: 53.0%; Read bytes: 38012416; Write bytes: 494029312; Read time: 390; Write time: 1545 09:10:24 INFO - install - Wall time: 22s; CPU: 55.0%; Read bytes: 196569600; Write bytes: 184745984; Read time: 17561; Write time: 355 09:10:24 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 30899712; Write bytes: 298494464; Read time: 297; Write time: 1159 09:10:24 INFO - Running post-run listener: _upload_blobber_files 09:10:24 INFO - Blob upload gear active. 09:10:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:10:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:10:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:10:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:10:24 INFO - (blobuploader) - INFO - Open directory for files ... 09:10:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:10:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:10:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:10:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:10:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:10:25 INFO - (blobuploader) - INFO - Done attempting. 09:10:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:10:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:10:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:10:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:10:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:10:26 INFO - (blobuploader) - INFO - Done attempting. 09:10:26 INFO - (blobuploader) - INFO - Iteration through files over. 09:10:26 INFO - Return code: 0 09:10:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:10:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:10:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b36a28ab25a3ef0239f933aa556742aace1542a8f2134dc6c3cc245847e74a2da14cb0125ebac3fe24fdaadbea1fcb1c896f50f54f38a780280d2578bbd52ebb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cc6c91d777022f6ce22ab74802bcfd00e2c6a25f303329fe48baeb37f385cbe676504cf1c30e46e92d0076bda61448a738928092f4dc1edd7419fc537d662140"} 09:10:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:10:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:10:26 INFO - Contents: 09:10:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b36a28ab25a3ef0239f933aa556742aace1542a8f2134dc6c3cc245847e74a2da14cb0125ebac3fe24fdaadbea1fcb1c896f50f54f38a780280d2578bbd52ebb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cc6c91d777022f6ce22ab74802bcfd00e2c6a25f303329fe48baeb37f385cbe676504cf1c30e46e92d0076bda61448a738928092f4dc1edd7419fc537d662140"} 09:10:26 INFO - Running post-run listener: copy_logs_to_upload_dir 09:10:26 INFO - Copying logs to upload dir... 09:10:26 INFO - mkdir: /builds/slave/test/build/upload/logs 09:10:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.981943 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-07-26 09:10:26.930913) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 09:10:26.934125) ========= 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.rMZ3xf8UTn/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.5VKs5pjg1K/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b36a28ab25a3ef0239f933aa556742aace1542a8f2134dc6c3cc245847e74a2da14cb0125ebac3fe24fdaadbea1fcb1c896f50f54f38a780280d2578bbd52ebb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cc6c91d777022f6ce22ab74802bcfd00e2c6a25f303329fe48baeb37f385cbe676504cf1c30e46e92d0076bda61448a738928092f4dc1edd7419fc537d662140"} build_url:https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011214 build_url: 'https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b36a28ab25a3ef0239f933aa556742aace1542a8f2134dc6c3cc245847e74a2da14cb0125ebac3fe24fdaadbea1fcb1c896f50f54f38a780280d2578bbd52ebb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cc6c91d777022f6ce22ab74802bcfd00e2c6a25f303329fe48baeb37f385cbe676504cf1c30e46e92d0076bda61448a738928092f4dc1edd7419fc537d662140"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 09:10:26.973165) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 09:10:26.973967) ========= 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.rMZ3xf8UTn/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.5VKs5pjg1K/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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.005088 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 09:10:27.026995) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 09:10:27.027553) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 09:10:27.027991) ========= ========= Total master_lag: 0.19 =========