builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0088 starttime: 1467235579.13 results: success (0) buildid: 20160629123126 builduid: d78df8e0929d4d3fba4a4b89258717ab revision: 311fec989776d55026e1ce3c8900350e1483209e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 14:26:19.127243) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 14:26:19.127729) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 14:26:19.128011) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 14:26:19.150400) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 14:26:19.150691) ========= 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.7zJmtIB6qZ/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.7qC0T7clAt/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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-06-29 14:26:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.19M=0.001s 2016-06-29 14:26:19 (8.19 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133323 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 14:26:19.305534) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 14:26:19.305881) ========= 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.7zJmtIB6qZ/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.7qC0T7clAt/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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.021179 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 14:26:19.354741) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-29 14:26:19.355090) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 311fec989776d55026e1ce3c8900350e1483209e --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 311fec989776d55026e1ce3c8900350e1483209e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7zJmtIB6qZ/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.7qC0T7clAt/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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-06-29 14:26:19,426 truncating revision to first 12 chars 2016-06-29 14:26:19,427 Setting DEBUG logging. 2016-06-29 14:26:19,427 attempt 1/10 2016-06-29 14:26:19,427 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/311fec989776?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 14:26:21,111 unpacking tar archive at: mozilla-beta-311fec989776/testing/mozharness/ program finished with exit code 0 elapsedTime=1.956173 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-29 14:26:21.336086) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 14:26:21.336406) ========= script_repo_revision: 311fec989776d55026e1ce3c8900350e1483209e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 14:26:21.336809) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 14:26:21.337100) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 14:26:21.355337) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-06-29 14:26:21.355625) ========= /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.7zJmtIB6qZ/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.7qC0T7clAt/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 14:26:21 INFO - MultiFileLogger online at 20160629 14:26:21 in /builds/slave/test 14:26:21 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 14:26:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:26:21 INFO - {'append_to_log': False, 14:26:21 INFO - 'base_work_dir': '/builds/slave/test', 14:26:21 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:26:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:26:21 INFO - 'branch': 'Mozilla-Beta', 14:26:21 INFO - 'buildbot_json_path': 'buildprops.json', 14:26:21 INFO - 'config_files': ('talos/mac_config.py',), 14:26:21 INFO - 'default_actions': ('clobber', 14:26:21 INFO - 'read-buildbot-config', 14:26:21 INFO - 'download-and-extract', 14:26:21 INFO - 'populate-webroot', 14:26:21 INFO - 'create-virtualenv', 14:26:21 INFO - 'install', 14:26:21 INFO - 'run-tests'), 14:26:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:26:21 INFO - 'download_minidump_stackwalk': True, 14:26:21 INFO - 'download_symbols': 'ondemand', 14:26:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:26:21 INFO - 'tooltool.py': '/tools/tooltool.py', 14:26:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:26:21 INFO - '/tools/misc-python/virtualenv.py')}, 14:26:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:26:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:26:21 INFO - 'installer_path': 'installer.exe', 14:26:21 INFO - 'log_level': 'info', 14:26:21 INFO - 'log_name': 'talos', 14:26:21 INFO - 'log_to_console': True, 14:26:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:26:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:26:21 INFO - 'opt_config_files': (), 14:26:21 INFO - 'pip_index': False, 14:26:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:26:21 INFO - 'cmd': ('bash', 14:26:21 INFO - '-c', 14:26:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:26:21 INFO - 'enabled': True, 14:26:21 INFO - 'halt_on_failure': False, 14:26:21 INFO - 'name': 'check_screen_resolution'},), 14:26:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:26:21 INFO - 'cmd': ('bash', 14:26:21 INFO - '-c', 14:26:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:26:21 INFO - 'enabled': True, 14:26:21 INFO - 'halt_on_failure': False, 14:26:21 INFO - 'name': 'check_screen_resolution'},), 14:26:21 INFO - 'run_cmd_checks_enabled': True, 14:26:21 INFO - 'sps_profile': False, 14:26:21 INFO - 'sps_profile_interval': 0, 14:26:21 INFO - 'suite': 'dromaeojs-e10s', 14:26:21 INFO - 'system_bits': '32', 14:26:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:26:21 INFO - 'title': 't-yosemite-r7-0088', 14:26:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:26:21 INFO - 'use_talos_json': True, 14:26:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:26:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:26:21 INFO - 'work_dir': 'build'} 14:26:21 INFO - ##### 14:26:21 INFO - ##### Running clobber step. 14:26:21 INFO - ##### 14:26:21 INFO - Running pre-action listener: _resource_record_pre_action 14:26:21 INFO - Running main action method: clobber 14:26:21 INFO - rmtree: /builds/slave/test/build 14:26:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:26:23 INFO - Running post-action listener: _resource_record_post_action 14:26:23 INFO - ##### 14:26:23 INFO - ##### Running read-buildbot-config step. 14:26:23 INFO - ##### 14:26:23 INFO - Running pre-action listener: _resource_record_pre_action 14:26:23 INFO - Running main action method: read_buildbot_config 14:26:23 INFO - Using buildbot properties: 14:26:23 INFO - { 14:26:23 INFO - "project": "", 14:26:23 INFO - "product": "firefox", 14:26:23 INFO - "script_repo_revision": "production", 14:26:23 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 14:26:23 INFO - "repository": "", 14:26:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 14:26:23 INFO - "buildid": "20160629123126", 14:26:23 INFO - "pgo_build": "False", 14:26:23 INFO - "basedir": "/builds/slave/test", 14:26:23 INFO - "buildnumber": 15, 14:26:23 INFO - "slavename": "t-yosemite-r7-0088", 14:26:23 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 14:26:23 INFO - "platform": "yosemite_r7", 14:26:23 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:26:23 INFO - "branch": "mozilla-beta", 14:26:23 INFO - "repo_path": "releases/mozilla-beta", 14:26:23 INFO - "revision": "311fec989776d55026e1ce3c8900350e1483209e", 14:26:23 INFO - "stage_platform": "macosx64", 14:26:23 INFO - "builduid": "d78df8e0929d4d3fba4a4b89258717ab", 14:26:23 INFO - "slavebuilddir": "test" 14:26:23 INFO - } 14:26:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/EJvlMMVWTzy1ItfIuTzEyg/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 14:26:23 INFO - Running post-action listener: _resource_record_post_action 14:26:23 INFO - ##### 14:26:23 INFO - ##### Running download-and-extract step. 14:26:23 INFO - ##### 14:26:23 INFO - Running pre-action listener: _resource_record_pre_action 14:26:23 INFO - Running main action method: download_and_extract 14:26:23 INFO - mkdir: /builds/slave/test/build/tests 14:26: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')]} 14:26:23 INFO - https://queue.taskcluster.net/v1/task/EJvlMMVWTzy1ItfIuTzEyg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:26:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EJvlMMVWTzy1ItfIuTzEyg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 14:26:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EJvlMMVWTzy1ItfIuTzEyg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 14:26:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EJvlMMVWTzy1ItfIuTzEyg/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 14:26:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EJvlMMVWTzy1ItfIuTzEyg/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 14:26:25 INFO - Downloaded 1165 bytes. 14:26:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 14:26:25 INFO - Using the following test package requirements: 14:26:25 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 14:26:25 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:26:25 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 14:26:25 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:26:25 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 14:26:25 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:26:25 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:26:25 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 14:26:25 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 14:26:25 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:26:25 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 14:26:25 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:26:25 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 14:26:25 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:26:25 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 14:26:25 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 14:26:25 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 14:26:25 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 14:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:26:25 INFO - https://queue.taskcluster.net/v1/task/EJvlMMVWTzy1ItfIuTzEyg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:26:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EJvlMMVWTzy1ItfIuTzEyg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 14:26:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EJvlMMVWTzy1ItfIuTzEyg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 14:26:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EJvlMMVWTzy1ItfIuTzEyg/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 14:26:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EJvlMMVWTzy1ItfIuTzEyg/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 14:26:29 INFO - Downloaded 18350397 bytes. 14:26:29 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'] 14:26:29 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 14:26:32 INFO - Return code: 0 14:26:32 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 14:26:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:26:32 INFO - https://queue.taskcluster.net/v1/task/EJvlMMVWTzy1ItfIuTzEyg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:26:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EJvlMMVWTzy1ItfIuTzEyg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 14:26:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EJvlMMVWTzy1ItfIuTzEyg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 14:26:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EJvlMMVWTzy1ItfIuTzEyg/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 14:26:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EJvlMMVWTzy1ItfIuTzEyg/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 14:26:34 INFO - Downloaded 18350397 bytes. 14:26:34 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'] 14:26:34 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 14:26:37 INFO - Return code: 0 14:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:26:37 INFO - https://queue.taskcluster.net/v1/task/EJvlMMVWTzy1ItfIuTzEyg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:26:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EJvlMMVWTzy1ItfIuTzEyg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 14:26:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EJvlMMVWTzy1ItfIuTzEyg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 14:26:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EJvlMMVWTzy1ItfIuTzEyg/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 14:26:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EJvlMMVWTzy1ItfIuTzEyg/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 14:26:39 INFO - Downloaded 10840145 bytes. 14:26:39 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'] 14:26:39 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 14:26:39 INFO - Return code: 0 14:26:39 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')]} 14:26:39 INFO - https://queue.taskcluster.net/v1/task/EJvlMMVWTzy1ItfIuTzEyg/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 14:26:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EJvlMMVWTzy1ItfIuTzEyg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 14:26:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EJvlMMVWTzy1ItfIuTzEyg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 14:26:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EJvlMMVWTzy1ItfIuTzEyg/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 14:26:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EJvlMMVWTzy1ItfIuTzEyg/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 14:26:43 INFO - Downloaded 86199743 bytes. 14:26:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EJvlMMVWTzy1ItfIuTzEyg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 14:26:43 INFO - mkdir: /builds/slave/test/properties 14:26:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:26:43 INFO - Writing to file /builds/slave/test/properties/build_url 14:26:43 INFO - Contents: 14:26:43 INFO - build_url:https://queue.taskcluster.net/v1/task/EJvlMMVWTzy1ItfIuTzEyg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 14:26:44 INFO - Running post-action listener: _resource_record_post_action 14:26:44 INFO - Running post-action listener: set_extra_try_arguments 14:26:44 INFO - ##### 14:26:44 INFO - ##### Running populate-webroot step. 14:26:44 INFO - ##### 14:26:44 INFO - Running pre-action listener: _resource_record_pre_action 14:26:44 INFO - Running main action method: populate_webroot 14:26:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:26:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:26:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:26:44 INFO - '--tppagecycles', 14:26:44 INFO - '7'], 14:26:44 INFO - 'tests': ['tsvgm']}}, 14:26:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:26:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:26:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:26:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:26:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:26:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:26:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:26:44 INFO - 'talos_options': ['--disable-e10s'], 14:26:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:26:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:26:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:26:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:26:44 INFO - 'talos_options': ['--disable-e10s'], 14:26:44 INFO - 'tests': ['damp', 'tps']}, 14:26:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:26:44 INFO - 'tests': ['damp', 'tps']}, 14:26:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:26:44 INFO - 'tests': ['dromaeo_dom']}, 14:26:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:26:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:26:44 INFO - 'tests': ['a11yr', 14:26:44 INFO - 'ts_paint', 14:26:44 INFO - 'tpaint', 14:26:44 INFO - 'sessionrestore', 14:26:44 INFO - 'sessionrestore_no_auto_restore', 14:26:44 INFO - 'tabpaint']}, 14:26:44 INFO - 'other-e10s': {'tests': ['a11yr', 14:26:44 INFO - 'ts_paint', 14:26:44 INFO - 'tpaint', 14:26:44 INFO - 'sessionrestore', 14:26:44 INFO - 'sessionrestore_no_auto_restore', 14:26:44 INFO - 'tabpaint']}, 14:26:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:26:44 INFO - 'ts_paint', 14:26:44 INFO - 'tpaint', 14:26:44 INFO - 'sessionrestore', 14:26:44 INFO - 'sessionrestore_no_auto_restore', 14:26:44 INFO - 'tabpaint']}, 14:26:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:26:44 INFO - 'ts_paint', 14:26:44 INFO - 'tpaint', 14:26:44 INFO - 'sessionrestore', 14:26:44 INFO - 'sessionrestore_no_auto_restore', 14:26:44 INFO - 'tabpaint']}, 14:26:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:26:44 INFO - 'tests': ['a11yr', 14:26:44 INFO - 'ts_paint', 14:26:44 INFO - 'tpaint', 14:26:44 INFO - 'sessionrestore', 14:26:44 INFO - 'sessionrestore_no_auto_restore', 14:26:44 INFO - 'tabpaint']}, 14:26:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:26:44 INFO - 'tests': ['a11yr', 14:26:44 INFO - 'ts_paint', 14:26:44 INFO - 'tpaint', 14:26:44 INFO - 'sessionrestore', 14:26:44 INFO - 'sessionrestore_no_auto_restore', 14:26:44 INFO - 'tabpaint']}, 14:26:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:26:44 INFO - 'tests': ['tsvgx', 14:26:44 INFO - 'tsvgr_opacity', 14:26:44 INFO - 'tart', 14:26:44 INFO - 'tscrollx', 14:26:44 INFO - 'cart']}, 14:26:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:26:44 INFO - 'tsvgr_opacity', 14:26:44 INFO - 'tart', 14:26:44 INFO - 'tscrollx', 14:26:44 INFO - 'cart']}, 14:26:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:26:44 INFO - 'talos_options': ['--disable-e10s'], 14:26:44 INFO - 'tests': ['tp5o']}, 14:26:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:26:44 INFO - 'tests': ['tp5o']}, 14:26:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:26:44 INFO - 'talos_options': ['--disable-e10s', 14:26:44 INFO - '--xperf_path', 14:26:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:26:44 INFO - 'tests': ['tp5n']}, 14:26:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:26:44 INFO - 'talos_options': ['--xperf_path', 14:26:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:26:44 INFO - 'tests': ['tp5n']}}, 14:26:44 INFO - 'talos.zip': {'path': '', 14:26:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:26:44 INFO - Running post-action listener: _resource_record_post_action 14:26:44 INFO - ##### 14:26:44 INFO - ##### Running create-virtualenv step. 14:26:44 INFO - ##### 14:26:44 INFO - Running pre-action listener: _resource_record_pre_action 14:26:44 INFO - Running main action method: create_virtualenv 14:26:44 INFO - Creating virtualenv /builds/slave/test/build/venv 14:26:44 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 14:26:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:26:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:26:44 INFO - Using real prefix '/tools/python27' 14:26:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:26:45 INFO - Installing distribute.............................................................................................................................................................................................done. 14:26:47 INFO - Installing pip.................done. 14:26:47 INFO - Return code: 0 14:26:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:26: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')]} 14:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26: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')]} 14:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:47 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 0x108e35a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e45420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe620da4110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cd4e00>, '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 0x108b3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ccfb20>, '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.7zJmtIB6qZ/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.7qC0T7clAt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 14:26:47 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 14:26:47 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 14:26:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7zJmtIB6qZ/Render', 14:26:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:26:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:26:47 INFO - 'HOME': '/Users/cltbld', 14:26:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:26:47 INFO - 'LOGNAME': 'cltbld', 14:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:26:47 INFO - 'MOZ_NO_REMOTE': '1', 14:26:47 INFO - 'NO_EM_RESTART': '1', 14:26:47 INFO - 'PAGER': '/bin/cat', 14:26:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:26:47 INFO - 'PWD': '/builds/slave/test', 14:26:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:26:47 INFO - 'SHELL': '/bin/bash', 14:26:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7qC0T7clAt/Listeners', 14:26:47 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 14:26:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:26:47 INFO - 'USER': 'cltbld', 14:26:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:26:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:26:47 INFO - 'XPC_FLAGS': '0x0', 14:26:47 INFO - 'XPC_SERVICE_NAME': '0', 14:26:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:26:48 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 14:26:48 INFO - Cleaning up... 14:26:48 INFO - Return code: 0 14:26:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:26: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')]} 14:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:26:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26: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')]} 14:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:26:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:48 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 0x108e35a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e45420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe620da4110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cd4e00>, '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 0x108b3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ccfb20>, '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.7zJmtIB6qZ/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.7qC0T7clAt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 14:26:48 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 14:26:48 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 14:26:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7zJmtIB6qZ/Render', 14:26:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:26:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:26:48 INFO - 'HOME': '/Users/cltbld', 14:26:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:26:48 INFO - 'LOGNAME': 'cltbld', 14:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:26:48 INFO - 'MOZ_NO_REMOTE': '1', 14:26:48 INFO - 'NO_EM_RESTART': '1', 14:26:48 INFO - 'PAGER': '/bin/cat', 14:26:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:26:48 INFO - 'PWD': '/builds/slave/test', 14:26:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:26:48 INFO - 'SHELL': '/bin/bash', 14:26:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7qC0T7clAt/Listeners', 14:26:48 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 14:26:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:26:48 INFO - 'USER': 'cltbld', 14:26:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:26:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:26:48 INFO - 'XPC_FLAGS': '0x0', 14:26:48 INFO - 'XPC_SERVICE_NAME': '0', 14:26:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:26:48 INFO - Downloading/unpacking psutil>=0.7.1 14:26:48 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 14:26:48 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 14:26:48 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 14:26:48 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 14:26:48 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 14:26:48 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 14:26:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:26:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:26:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:26:51 INFO - Installing collected packages: psutil 14:26:51 INFO - Running setup.py install for psutil 14:26:51 INFO - building 'psutil._psutil_osx' extension 14:26:51 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 14:26:51 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 14:26:51 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 14:26:51 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 14:26:51 INFO - building 'psutil._psutil_posix' extension 14:26:51 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 14:26:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:26:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:26:51 INFO - ^ 14:26:51 INFO - 1 warning generated. 14:26:51 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 14:26:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:26:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:26:51 INFO - Successfully installed psutil 14:26:51 INFO - Cleaning up... 14:26:51 INFO - Return code: 0 14:26:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:26:51 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')]} 14:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:26:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:51 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')]} 14:26:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:26:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:51 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 0x108e35a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e45420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe620da4110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cd4e00>, '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 0x108b3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ccfb20>, '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.7zJmtIB6qZ/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.7qC0T7clAt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 14:26:51 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 14:26:51 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 14:26:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7zJmtIB6qZ/Render', 14:26:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:26:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:26:51 INFO - 'HOME': '/Users/cltbld', 14:26:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:26:51 INFO - 'LOGNAME': 'cltbld', 14:26:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:26:51 INFO - 'MOZ_NO_REMOTE': '1', 14:26:51 INFO - 'NO_EM_RESTART': '1', 14:26:51 INFO - 'PAGER': '/bin/cat', 14:26:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:26:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:26:51 INFO - 'PWD': '/builds/slave/test', 14:26:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:26:51 INFO - 'SHELL': '/bin/bash', 14:26:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7qC0T7clAt/Listeners', 14:26:51 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 14:26:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:26:51 INFO - 'USER': 'cltbld', 14:26:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:26:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:26:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:26:51 INFO - 'XPC_FLAGS': '0x0', 14:26:51 INFO - 'XPC_SERVICE_NAME': '0', 14:26:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:26:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:26:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:26:52 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 14:26:52 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 14:26:52 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 14:26:52 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 14:26:52 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 14:26:52 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 14:26:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:26:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:26:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:26:54 INFO - Installing collected packages: mozsystemmonitor 14:26:54 INFO - Running setup.py install for mozsystemmonitor 14:26:54 INFO - Successfully installed mozsystemmonitor 14:26:54 INFO - Cleaning up... 14:26:54 INFO - Return code: 0 14:26:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:26:54 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')]} 14:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:54 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')]} 14:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:54 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 0x108e35a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e45420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe620da4110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cd4e00>, '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 0x108b3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ccfb20>, '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.7zJmtIB6qZ/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.7qC0T7clAt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 14:26:54 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 14:26:54 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 14:26:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7zJmtIB6qZ/Render', 14:26:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:26:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:26:54 INFO - 'HOME': '/Users/cltbld', 14:26:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:26:54 INFO - 'LOGNAME': 'cltbld', 14:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:26:54 INFO - 'MOZ_NO_REMOTE': '1', 14:26:54 INFO - 'NO_EM_RESTART': '1', 14:26:54 INFO - 'PAGER': '/bin/cat', 14:26:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:26:54 INFO - 'PWD': '/builds/slave/test', 14:26:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:26:54 INFO - 'SHELL': '/bin/bash', 14:26:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7qC0T7clAt/Listeners', 14:26:54 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 14:26:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:26:54 INFO - 'USER': 'cltbld', 14:26:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:26:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:26:54 INFO - 'XPC_FLAGS': '0x0', 14:26:54 INFO - 'XPC_SERVICE_NAME': '0', 14:26:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:26:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:26:55 INFO - Downloading/unpacking blobuploader==1.2.4 14:26:55 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 14:26:55 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 14:26:55 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 14:26:55 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 14:26:55 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 14:26:55 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 14:26:57 INFO - Downloading blobuploader-1.2.4.tar.gz 14:26:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:26:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:26:57 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 14:26:57 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 14:26:57 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 14:26:57 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 14:26:57 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 14:26:57 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 14:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:26:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:26:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:26:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:26:58 INFO - Downloading docopt-0.6.1.tar.gz 14:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:26:58 INFO - Installing collected packages: blobuploader, requests, docopt 14:26:58 INFO - Running setup.py install for blobuploader 14:26:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:26:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:26:59 INFO - Running setup.py install for requests 14:26:59 INFO - Running setup.py install for docopt 14:26:59 INFO - Successfully installed blobuploader requests docopt 14:26:59 INFO - Cleaning up... 14:26:59 INFO - Return code: 0 14:26:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:26:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:26:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:59 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 0x108e35a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e45420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe620da4110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cd4e00>, '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 0x108b3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ccfb20>, '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.7zJmtIB6qZ/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.7qC0T7clAt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 14:26:59 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 14:26:59 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 14:26:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7zJmtIB6qZ/Render', 14:26:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:26:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:26:59 INFO - 'HOME': '/Users/cltbld', 14:26:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:26:59 INFO - 'LOGNAME': 'cltbld', 14:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:26:59 INFO - 'MOZ_NO_REMOTE': '1', 14:26:59 INFO - 'NO_EM_RESTART': '1', 14:26:59 INFO - 'PAGER': '/bin/cat', 14:26:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:26:59 INFO - 'PWD': '/builds/slave/test', 14:26:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:26:59 INFO - 'SHELL': '/bin/bash', 14:26:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7qC0T7clAt/Listeners', 14:26:59 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 14:26:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:26:59 INFO - 'USER': 'cltbld', 14:26:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:26:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:26:59 INFO - 'XPC_FLAGS': '0x0', 14:26:59 INFO - 'XPC_SERVICE_NAME': '0', 14:26:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:27:00 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-prOGGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:27:00 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-hvZt5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:27:00 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-ldyfGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:27:00 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-fhCUtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:27:00 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-IwtBoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:27:00 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-e5t4Dk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:27:00 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-uOkOs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:27:00 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-TMyHQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:27:00 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-zSl07X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:27:00 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-HBSob0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:27:01 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-brdpOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:27:01 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-h1y0wX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:27:01 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-UfJ7hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:27:01 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-M_8YL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:27:01 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-dipya8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:27:01 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-1BBobZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:27:01 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-6_GttE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:27:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:27:01 INFO - Running setup.py install for manifestparser 14:27:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:27:01 INFO - Running setup.py install for mozcrash 14:27:02 INFO - Running setup.py install for mozdebug 14:27:02 INFO - Running setup.py install for mozdevice 14:27:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:27:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:27:02 INFO - Running setup.py install for mozfile 14:27:02 INFO - Running setup.py install for mozhttpd 14:27:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:27:02 INFO - Running setup.py install for mozinfo 14:27:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:27:02 INFO - Running setup.py install for mozInstall 14:27:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:27:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:27:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:27:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:27:02 INFO - Running setup.py install for mozleak 14:27:03 INFO - Running setup.py install for mozlog 14:27:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:27:03 INFO - Running setup.py install for moznetwork 14:27:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:27:03 INFO - Running setup.py install for mozprocess 14:27:03 INFO - Running setup.py install for mozprofile 14:27:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:27:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:27:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:27:03 INFO - Running setup.py install for mozrunner 14:27:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:27:03 INFO - Running setup.py install for mozscreenshot 14:27:04 INFO - Running setup.py install for moztest 14:27:04 INFO - Running setup.py install for mozversion 14:27:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:27:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:27:04 INFO - Cleaning up... 14:27:04 INFO - Return code: 0 14:27:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:27: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')]} 14:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27: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')]} 14:27:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:04 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 0x108e35a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e45420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe620da4110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cd4e00>, '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 0x108b3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ccfb20>, '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.7zJmtIB6qZ/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.7qC0T7clAt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 14:27:04 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 14:27:04 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 14:27:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7zJmtIB6qZ/Render', 14:27:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:04 INFO - 'HOME': '/Users/cltbld', 14:27:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:04 INFO - 'LOGNAME': 'cltbld', 14:27:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:04 INFO - 'MOZ_NO_REMOTE': '1', 14:27:04 INFO - 'NO_EM_RESTART': '1', 14:27:04 INFO - 'PAGER': '/bin/cat', 14:27:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:04 INFO - 'PWD': '/builds/slave/test', 14:27:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:04 INFO - 'SHELL': '/bin/bash', 14:27:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7qC0T7clAt/Listeners', 14:27:04 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 14:27:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:04 INFO - 'USER': 'cltbld', 14:27:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:04 INFO - 'XPC_FLAGS': '0x0', 14:27:04 INFO - 'XPC_SERVICE_NAME': '0', 14:27:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:27:04 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-L7G4b3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:27:04 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)) 14:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:27:04 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-gyODx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:27:04 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)) 14:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:27:04 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-QUCRyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:27:04 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)) 14:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:27:05 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-a6Jb0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:27:05 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)) 14:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:27:05 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-3XBxez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:27:05 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)) 14:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:27:05 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-oS2__b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:27:05 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)) 14:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:27:05 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-4pB5Im-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:27:05 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)) 14:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:27:05 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-93JcaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:27:05 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)) 14:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:27:05 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-us55q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:27:05 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)) 14:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:27:05 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-T1O0F2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:27:05 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)) 14:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:27:05 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-DpgSA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:27:05 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)) 14:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:27:05 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-PyMMZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:27:05 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)) 14:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:27:05 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-Ygmpif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:27:06 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)) 14:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:27:06 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-RLEhrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:27:06 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)) 14:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:27:06 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-VZ1i2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:27:06 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)) 14:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:27:06 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-C7ZdUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:27:06 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)) 14:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:27:06 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-Phf_Ma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:27:06 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)) 14:27:06 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)) 14:27:06 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)) 14:27:06 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)) 14:27:06 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)) 14:27:06 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)) 14:27:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:27:06 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 14:27:06 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 14:27:06 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 14:27:06 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 14:27:06 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 14:27:06 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 14:27:08 INFO - Downloading blessings-1.6.tar.gz 14:27:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:27:09 INFO - Installing collected packages: blessings 14:27:09 INFO - Running setup.py install for blessings 14:27:09 INFO - Successfully installed blessings 14:27:09 INFO - Cleaning up... 14:27:09 INFO - Return code: 0 14:27:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:27:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:27:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:27:09 INFO - Reading from file tmpfile_stdout 14:27:09 INFO - Current package versions: 14:27:09 INFO - blessings == 1.6 14:27:09 INFO - blobuploader == 1.2.4 14:27:09 INFO - docopt == 0.6.1 14:27:09 INFO - manifestparser == 1.1 14:27:09 INFO - mozInstall == 1.12 14:27:09 INFO - mozcrash == 0.17 14:27:09 INFO - mozdebug == 0.1 14:27:09 INFO - mozdevice == 0.48 14:27:09 INFO - mozfile == 1.2 14:27:09 INFO - mozhttpd == 0.7 14:27:09 INFO - mozinfo == 0.9 14:27:09 INFO - mozleak == 0.1 14:27:09 INFO - mozlog == 3.1 14:27:09 INFO - moznetwork == 0.27 14:27:09 INFO - mozprocess == 0.22 14:27:09 INFO - mozprofile == 0.28 14:27:09 INFO - mozrunner == 6.11 14:27:09 INFO - mozscreenshot == 0.1 14:27:09 INFO - mozsystemmonitor == 0.0 14:27:09 INFO - moztest == 0.7 14:27:09 INFO - mozversion == 1.4 14:27:09 INFO - psutil == 3.1.1 14:27:09 INFO - requests == 1.2.3 14:27:09 INFO - wsgiref == 0.1.2 14:27:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:27: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')]} 14:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27: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')]} 14:27:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:09 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 0x108e35a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e45420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe620da4110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cd4e00>, '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 0x108b3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ccfb20>, '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.7zJmtIB6qZ/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.7qC0T7clAt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 14:27:09 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 14:27:09 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 14:27:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7zJmtIB6qZ/Render', 14:27:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:09 INFO - 'HOME': '/Users/cltbld', 14:27:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:09 INFO - 'LOGNAME': 'cltbld', 14:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:09 INFO - 'MOZ_NO_REMOTE': '1', 14:27:09 INFO - 'NO_EM_RESTART': '1', 14:27:09 INFO - 'PAGER': '/bin/cat', 14:27:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:09 INFO - 'PWD': '/builds/slave/test', 14:27:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:09 INFO - 'SHELL': '/bin/bash', 14:27:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7qC0T7clAt/Listeners', 14:27:09 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 14:27:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:09 INFO - 'USER': 'cltbld', 14:27:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:09 INFO - 'XPC_FLAGS': '0x0', 14:27:09 INFO - 'XPC_SERVICE_NAME': '0', 14:27:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:09 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)) 14:27:09 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)) 14:27:09 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)) 14:27:09 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)) 14:27:09 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)) 14:27:09 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)) 14:27:09 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)) 14:27:09 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)) 14:27:09 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)) 14:27:09 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)) 14:27:09 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)) 14:27:09 INFO - Cleaning up... 14:27:09 INFO - Return code: 0 14:27:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:27: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')]} 14:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27: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')]} 14:27:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108e35a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e45420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe620da4110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cd4e00>, '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 0x108b3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ccfb20>, '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.7zJmtIB6qZ/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.7qC0T7clAt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 14:27:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:27:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:27:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7zJmtIB6qZ/Render', 14:27:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:09 INFO - 'HOME': '/Users/cltbld', 14:27:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:09 INFO - 'LOGNAME': 'cltbld', 14:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:09 INFO - 'MOZ_NO_REMOTE': '1', 14:27:09 INFO - 'NO_EM_RESTART': '1', 14:27:09 INFO - 'PAGER': '/bin/cat', 14:27:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:09 INFO - 'PWD': '/builds/slave/test', 14:27:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:09 INFO - 'SHELL': '/bin/bash', 14:27:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7qC0T7clAt/Listeners', 14:27:09 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 14:27:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:09 INFO - 'USER': 'cltbld', 14:27:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:09 INFO - 'XPC_FLAGS': '0x0', 14:27:09 INFO - 'XPC_SERVICE_NAME': '0', 14:27:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:10 INFO - Downloading/unpacking jsonschema 14:27:10 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 14:27:10 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 14:27:10 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 14:27:10 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 14:27:10 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 14:27:10 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 14:27:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:27:12 INFO - Downloading/unpacking functools32 (from jsonschema) 14:27:12 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 14:27:12 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 14:27:12 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 14:27:12 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 14:27:12 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 14:27:12 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 14:27:12 INFO - Downloading functools32-3.2.3-2.tar.gz 14:27:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:27:12 INFO - warning: no files found matching '*.txt' 14:27:12 INFO - no previously-included directories found matching 'build' 14:27:12 INFO - no previously-included directories found matching 'dist' 14:27:12 INFO - no previously-included directories found matching '.git*' 14:27:12 INFO - Installing collected packages: jsonschema, functools32 14:27:13 INFO - Running setup.py install for functools32 14:27:13 INFO - warning: no files found matching '*.txt' 14:27:13 INFO - no previously-included directories found matching 'build' 14:27:13 INFO - no previously-included directories found matching 'dist' 14:27:13 INFO - no previously-included directories found matching '.git*' 14:27:13 INFO - Successfully installed jsonschema functools32 14:27:13 INFO - Cleaning up... 14:27:13 INFO - Return code: 0 14:27:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:27:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108e35a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e45420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe620da4110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cd4e00>, '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 0x108b3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ccfb20>, '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.7zJmtIB6qZ/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.7qC0T7clAt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 14:27:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:27:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:27:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7zJmtIB6qZ/Render', 14:27:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:13 INFO - 'HOME': '/Users/cltbld', 14:27:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:13 INFO - 'LOGNAME': 'cltbld', 14:27:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:13 INFO - 'MOZ_NO_REMOTE': '1', 14:27:13 INFO - 'NO_EM_RESTART': '1', 14:27:13 INFO - 'PAGER': '/bin/cat', 14:27:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:13 INFO - 'PWD': '/builds/slave/test', 14:27:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:13 INFO - 'SHELL': '/bin/bash', 14:27:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7qC0T7clAt/Listeners', 14:27:13 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 14:27:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:13 INFO - 'USER': 'cltbld', 14:27:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:13 INFO - 'XPC_FLAGS': '0x0', 14:27:13 INFO - 'XPC_SERVICE_NAME': '0', 14:27:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:13 INFO - Downloading/unpacking flake8 14:27:13 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 14:27:13 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 14:27:13 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 14:27:13 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 14:27:13 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 14:27:13 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 14:27:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:27:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:27: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 14:27: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 14:27: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 14:27: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 14:27: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 14:27: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 14:27:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:27:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:27: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 14:27: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 14:27: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 14:27: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 14:27: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 14:27: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 14:27:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:27: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 14:27: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 14:27: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 14:27: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 14:27: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 14:27: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 14:27:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:27:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:27:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:27:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:27:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:27:17 INFO - no previously-included directories found matching 'docs/_build' 14:27:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:27:17 INFO - Running setup.py install for pep8 14:27:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:27:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:27:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:27:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:27:17 INFO - no previously-included directories found matching 'docs/_build' 14:27:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:27:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:27:17 INFO - Cleaning up... 14:27:17 INFO - Return code: 0 14:27:17 INFO - Running post-action listener: _resource_record_post_action 14:27:17 INFO - Running post-action listener: _start_resource_monitoring 14:27:17 INFO - Starting resource monitoring. 14:27:17 INFO - ##### 14:27:17 INFO - ##### Running install step. 14:27:17 INFO - ##### 14:27:17 INFO - Running pre-action listener: _resource_record_pre_action 14:27:17 INFO - Running main action method: install 14:27:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:27:17 INFO - Reading from file tmpfile_stdout 14:27:17 INFO - Detecting whether we're running mozinstall >=1.0... 14:27:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:27:18 INFO - Reading from file tmpfile_stdout 14:27:18 INFO - Output received: 14:27:18 INFO - Usage: mozinstall [options] installer 14:27:18 INFO - Options: 14:27:18 INFO - -h, --help show this help message and exit 14:27:18 INFO - -d DEST, --destination=DEST 14:27:18 INFO - Directory to install application into. [default: 14:27:18 INFO - "/builds/slave/test"] 14:27:18 INFO - --app=APP Application being installed. [default: firefox] 14:27:18 INFO - mkdir: /builds/slave/test/build/application 14:27:18 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'] 14:27:18 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 14:27:39 INFO - Reading from file tmpfile_stdout 14:27:39 INFO - Output received: 14:27:39 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:27:39 INFO - Running post-action listener: _resource_record_post_action 14:27:39 INFO - ##### 14:27:39 INFO - ##### Running run-tests step. 14:27:39 INFO - ##### 14:27:39 INFO - Running pre-action listener: _resource_record_pre_action 14:27:39 INFO - Running main action method: run_tests 14:27:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:27:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:27:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:27:39 INFO - 2016-06-29 14:27:39.744 screenresolution[2355:34695] starting screenresolution argv=screenresolution get 14:27:39 INFO - 2016-06-29 14:27:39.746 screenresolution[2355:34695] Display 0: 1600x1200x32@60 14:27:39 INFO - 2016-06-29 14:27:39.752 screenresolution[2356:34697] starting screenresolution argv=screenresolution list 14:27:39 INFO - Available Modes on Display 0 14:27:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:27:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:27:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:27:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:27:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:27:39 INFO - Intel Iris: 14:27:39 INFO - Chipset Model: Intel Iris 14:27:39 INFO - Type: GPU 14:27:39 INFO - Bus: Built-In 14:27:39 INFO - VRAM (Dynamic, Max): 1536 MB 14:27:39 INFO - Vendor: Intel (0x8086) 14:27:39 INFO - Device ID: 0x0a2e 14:27:39 INFO - Revision ID: 0x0009 14:27:39 INFO - Displays: 14:27:39 INFO - Display: 14:27:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:27:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:27:39 INFO - Display Serial Number: 1600x1200 60 14:27:39 INFO - Main Display: Yes 14:27:39 INFO - Mirror: Off 14:27:39 INFO - Online: Yes 14:27:39 INFO - Rotation: Supported 14:27:39 INFO - Return code: 0 14:27:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:27:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:27:39 INFO - Python 2.7.3 14:27:39 INFO - Return code: 0 14:27:39 INFO - grabbing minidump binary from tooltool 14:27:39 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')]} 14:27:39 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 0x108cd4e00>, '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 0x108b3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ccfb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:27:39 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 14:27:39 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 14:27:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:27:40 INFO - Return code: 0 14:27:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:27:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:27:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:27:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:27:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:27:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:27:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:27:41 INFO - Return code: 0 14:27:41 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/EJvlMMVWTzy1ItfIuTzEyg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0088', '--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 14:27:41 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/EJvlMMVWTzy1ItfIuTzEyg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0088 --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 14:27:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7zJmtIB6qZ/Render', 14:27:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:41 INFO - 'HOME': '/Users/cltbld', 14:27:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:41 INFO - 'LOGNAME': 'cltbld', 14:27:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:27:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:41 INFO - 'MOZ_NO_REMOTE': '1', 14:27:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:27:41 INFO - 'NO_EM_RESTART': '1', 14:27:41 INFO - 'PAGER': '/bin/cat', 14:27:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:41 INFO - 'PWD': '/builds/slave/test', 14:27:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:27:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:41 INFO - 'SHELL': '/bin/bash', 14:27:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7qC0T7clAt/Listeners', 14:27:41 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 14:27:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:41 INFO - 'USER': 'cltbld', 14:27:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:41 INFO - 'XPC_FLAGS': '0x0', 14:27:41 INFO - 'XPC_SERVICE_NAME': '0', 14:27:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:41 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/EJvlMMVWTzy1ItfIuTzEyg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0088', '--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 14:27:41 INFO - mozversion application_buildid: 20160629123126 14:27:41 INFO - mozversion application_changeset: 311fec989776d55026e1ce3c8900350e1483209e 14:27:41 INFO - mozversion application_display_name: Firefox 14:27:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:27:41 INFO - mozversion application_name: Firefox 14:27:41 INFO - mozversion application_remotingname: firefox 14:27:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:27:41 INFO - mozversion application_vendor: Mozilla 14:27:41 INFO - mozversion application_version: 48.0 14:27:41 INFO - mozversion platform_buildid: 20160629123126 14:27:41 INFO - mozversion platform_changeset: 311fec989776d55026e1ce3c8900350e1483209e 14:27:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:27:41 INFO - mozversion platform_version: 48.0 14:27:41 INFO - using testdate: 1467235661 14:27:41 INFO - actual date: 1467235661 14:27:41 INFO - starting webserver on 'localhost:57385' 14:27:41 INFO - SUITE-START | Running 2 tests 14:27:41 INFO - TEST-START | dromaeo_css 14:27:41 INFO - operating with platform_type : mac_ 14:27:41 INFO - Initialising browser for dromaeo_css test... 14:27:41 INFO - TEST-INFO | started process 2374 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpjEVU7I/profile http://localhost:57385/getInfo.html) 14:27:44 INFO - PROCESS | 2374 | __metrics Screen width/height:1600/1200 14:27:44 INFO - PROCESS | 2374 | colorDepth:24 14:27:44 INFO - PROCESS | 2374 | Browser inner width/height: 1024/689 14:27:44 INFO - PROCESS | 2374 | __metrics 14:27:44 ERROR - PROCESS | 2374 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 14:27:44 INFO - TEST-INFO | 2374: exit 0 14:27:44 INFO - Browser initialized. 14:27:44 INFO - Running cycle 1/1 for dromaeo_css test... 14:27:44 INFO - TEST-INFO | started process 2378 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpjEVU7I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:27:56 INFO - PROCESS | 2378 | RSS: Main: 170942464 14:27:56 INFO - PROCESS | 2378 | 14:28:46 INFO - PROCESS | 2378 | 1467235726351 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] 14:30:56 INFO - PROCESS | 2378 | Cycle 1(1): loaded http://localhost:57385/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57385/tests/dromaeo/cssquery-ext.html) 14:30:58 INFO - PROCESS | 2378 | RSS: Main: 183525376 14:30:58 INFO - PROCESS | 2378 | 14:34:00 INFO - PROCESS | 2378 | Cycle 1(1): loaded http://localhost:57385/tests/dromaeo/cssquery-ext.html (next: http://localhost:57385/tests/dromaeo/cssquery-jquery.html) 14:34:00 INFO - PROCESS | 2378 | RSS: Main: 194433024 14:34:00 INFO - PROCESS | 2378 | 14:37:02 INFO - PROCESS | 2378 | Cycle 1(1): loaded http://localhost:57385/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57385/tests/dromaeo/cssquery-mootools.html) 14:37:03 INFO - PROCESS | 2378 | RSS: Main: 196333568 14:37:03 INFO - PROCESS | 2378 | 14:40:04 INFO - PROCESS | 2378 | Cycle 1(1): loaded http://localhost:57385/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57385/tests/dromaeo/cssquery-prototype.html) 14:40:05 INFO - PROCESS | 2378 | RSS: Main: 200192000 14:40:05 INFO - PROCESS | 2378 | 14:43:08 INFO - PROCESS | 2378 | Cycle 1(1): loaded http://localhost:57385/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57385/tests/dromaeo/cssquery-yui.html) 14:43:08 INFO - PROCESS | 2378 | RSS: Main: 199589888 14:43:08 INFO - PROCESS | 2378 | 14:46:10 INFO - PROCESS | 2378 | Cycle 1(1): loaded http://localhost:57385/tests/dromaeo/cssquery-yui.html (next: http://localhost:57385/tests/dromaeo/cssquery-dojo.html) 14:46:11 INFO - PROCESS | 2378 | RSS: Main: 204234752 14:46:11 INFO - PROCESS | 2378 | 14:46:11 INFO - PROCESS | 2378 | __start_tp_report 14:46:11 INFO - PROCESS | 2378 | _x_x_mozilla_page_load 14:46:11 INFO - PROCESS | 2378 | _x_x_mozilla_page_load_details 14:46:11 INFO - PROCESS | 2378 | |i|pagename|runs| 14:46:11 INFO - PROCESS | 2378 | |0;dojo.html;3594;3602.4236122220445;3622.040159357771;3631.7639353442023;3677.6138505456925;5868.178455016301;5889.234399528055;5898.941010589888;5914.231149950506;5948.375420580842;5832.941670583293;5934.1692163097205;5946.3161736400325;5977.3723759005225;5981.880362392761;5289.391719952207;5297.8940421191555;5348.117560602515;5386.218998245252;5433.347998240217;5330.493603107718;5421.810236641718;5430.429804870491;5438.53772429344;5511.200875873016;5426;5435.701036442994;5439.48324909133;5468.425815289397;5471.72641367932;5353.544948679367;5396.325459317585;5412.972935135299;5431.565474762009;5442.12925931853;5318.30861987943;5342.893142137135;5434.347878254595;5445.482679145475;5474.808381706661;5815.185873977604;5828.562857785683;5861;5878.177055212231;5891.204687367236;6191.535634827406;6211.565190436671;6239.781607643756;6280.309165991737;6295.18162638854;6387.489000879918;6398.680065996681;6406.391392817675;6412.775552855627;6425.646589437579;6123.08153776937;6128.724207410677;6134.969325153345;6140.478059364959;6159.414855588712;5384.6499977501335;6354.17395738551;6454.160959075384;6464.321246269168;6543.476521878239;5365.946340536622;6123.357047510036;6284.214473190851;6326;6336.144620476269;6482.092507049017;6491.480681545465;6498.0252962056065;6501.544891857525;6504.479641628658;5246.685198888079;6216.875662486725;6336.366363363719;6342.302346741854;6382.648954307465;6333.303336633059;6363.204599425072;6366.522510811707;6376.171097757262;6379.808605741835;5024.6231532634465;5037.647364684511;5058.873528161826;5137.922931156036;5156.252343410185;4558.2251017327135;4572.245579479349;4607.792649330788;4623.306504024423;4658.86023419298;4914.827981020647;6106.053561697944;6106.816795496142;6122.693865306717;6132;6198.752049917953;6357.1735674362035;6411.487081033506;6478.935210647834;6482.967585162044;5963.701814909237;6032.607880487842;6095.817125486243;6114.327423983358;6141.57009009374;5568.693721845257;5569.136783798518;5578.163275508706;5599.132134519156;5610.382857885629;6507.609543427409;6550.9999999999045;6619.834504137435;6623.370779775913;6653.334666533405;5168.793248270177;6401.135846660642;6409.134766806422;6433.774817881352;6473.643949582818;6621.966890165519;6651.301613330724;6671.5997040177745;6674.065630811788;6693;6206.503479721521;6245.156903817927;6326;6339.96830015847;6375.6174629522375;6414.903776443264;6439.517036222396;6451.645159516272;6465.741370345134;6466.708998095191;6094.421030002142;6180.845478862884;6238.407351301619;6239.5008399327035;6252.406021427957;6110.103144028831;6130.601510901777;6159.476444502267;6181.320054794059;6190.380961903954;6033.292287137267;6104.633721976696;6143.72353244114;6153.261608606996;6179.505639548735;6100.633961962297;6263.906041409474;6274.623522588477;6278.968605156945;6279.905801412891;6118.101457354478;6122.611623597991;6150.7847225346895;6206.224221972254;6219.906701399573 14:46:11 INFO - PROCESS | 2378 | |1;ext.html;555.2420945409515;562.836777334573;581.1196038002425;609.8627808743031;614.450067189865;28402.573961390597;33990.83004584977;37559.87320380386;38826.8058659707;41623.79188104055;38735.25691343889;39815.80092099535;43425.34861977065;43731.562684373144;44228.336574951405;9001.414908030989;9171.220446262076;9603.183729382994;9794.314397992144;9873.111419972201;9722.319437639368;9806.803863922718;9815.65645202418;9890.456024918627;9896.059874311964;8176.509409435424;8431.747047588582;9812.656557020506;9813.362131461432;9884.85172722406;8297.419180657356;9797.363171393836;9819.803603927918;9850.113489785917;9911.653092141813;8527.829443411098;9675.70972870815;9690.12788849007;9734.513274336327;9825.820901491796;40144.59855401438;40572.59427405718;41117.38323925144;41194.38208426876;41225.58774412277;3271.7219036381935;3333.0667413124365;3379.3629866074634;3419.230673098558;3420.6579342065843;28791.424171516453;29306.267343316587;29314.70685293141;29557.113286601438;29670.85164574185;2715;2784.470950519395;2794.1338185162663;2823.632927719404;2828.3494796196783;443557;444556;445107;446201.99999999674;446262;37733.43399849004;38198.23603527914;62543;62654.68672656608;62982;36384.45423318652;36540;36737.81631091881;36757.26485470329;36768.08079797973;15994.280257388446;16086.43697470583;16174.19129043543;16204.351825926831;16415.343386264416;13667.794983075262;13680.726385472235;13707.725845483234;13752.243626600633;13872;8382.916170838214;8386.119457457002;8482.151784821592;8539.231469167804;8547.059823419419;3550.0592343029116;3558.448440491728;3590.1024743814046;3622.8188590570894;3632.54593175853;1052.4369462337613;1064.9627263045757;1072.3325229268407;1084.6854412220368;1086.6577028236081;27989.440211195662;29162.125136245948;30717.539236911463;30820;31131.68868311288;1144.5879483385975;1163.761428907072;1165.522135924284;1228.7173949991372;1234.925904445736;12162.574309899112;13879.653008674662;15570.844291557167;15627.453039143802;15716.60708482297;507639;581368;648433;652267;660437;59841.700791495765;61714.382856170865;63046.0543091854;63178;63239.05141422882;1526.9465568705043;1542.383046781274;1552.4876790659055;1564.0224859462835;1570.2227397438342;24038;29947.251318717208;30111.397772044875;30672.539911900894;30729;53515;61600.69199653973;63492.365076348644;64335.356646432934;65233.673831630535;551160;580063;617443;617692;618433;41464.585354146075;42650.57349426466;43057.56942430536;44135.33796993112;44271.77864110788;47231.29153062638;47972.520274798204;48507.757461212466;48871.5112848867;48915.266271005254;37897.81051094727;38639.80680096582;39082;39228.803855980535;39265;38247;38273.234535308584;38501.844944651704;38630.42054369243;38896.222075557765;35789.82105089458;38753.612463876125;39328.623498177425;39506.802465987486;40083.39874901937;31968.840155800004;32772.83613581917;33694.49458258079;35050.773222937074;35179.47230791489;24913.501729964937;25060.74939250584;25087.247382578553;25314.493710126062;25481 14:46:11 INFO - PROCESS | 2378 | |2;jquery.html;414.71799176559927;417.18232264761065;417.6679539765886;421.3742592250508;427.7454914325975;20879.373618791422;21003.264885729004;21371.145154193815;21655.35033948982;21680.02439890205;21301.25445609404;21572.568548629017;21669.34991950244;21901.671474927887;21907.890460547715;5888.764449422018;6329.4619957303685;6332.715027823736;6333.936660633404;6353.30113687494;4550.954490455103;6252.124702541648;6298.149749783789;6375.617462952215;6392.424681778639;5922.437368449991;6110.419510146529;6135.8772824543485;6245.937540624604;6248.343923887995;5804.796832110877;6136.999999999977;6196.225471816023;6925.896111558331;7055.8588828223665;6184.350643182446;6184.81445556634;6187.845303867394;6214.316425193225;6238.282597501255;20027.699584506245;25462.745372546407;26091;26167;26673.933042678465;2170.6092903277404;2258.5144193998367;2315.5947709150832;2351.271105957159;2368.135630494874;10059.446730429896;10081.747956301078;10182.796344073076;10553.947230263877;10774.40740759258;1812.592166762468;1819.8271164239509;1830.2587452081796;1857.9535511612182;1872.9511473574842;76539.61730191369;78264.21735782626;79277.60361198215;105343;108559.45720271349;11744.236624619372;11893;12278.140530162802;12293.508259669514;12354.320512371725;15444.92277538605;15737.763933541006;15775.132367719885;15800.762988555181;15895.52313430599;9544.52277386128;9596.520173991272;9598.32811703174;9666.565004574812;9756.024397560188;9557.044295570387;9679.225661947028;9684.612615495442;9685.370450920667;9711.611535538641;4903.583195428358;4928.654994150446;4967.528084832007;5003.824866129668;5020.7740651670765;2050.4463794775625;2084.32259515658;2089.164334266275;2097.748270207585;2098.8320934325525;927.5084205371164;982.6020461713018;1001.8246806808925;1039.9064084232305;1054.293623272394;17636.735448968277;19778.71438356531;21249.68125478119;21775.346739597837;21781.455463613536;970.5923512124924;1001.839705647093;1032.339302846179;1054.9208809339177;1072.6245813965206;10215.642452514126;10959.50682219302;11184.608538701106;11365.09079273656;11574.88425115755;565302;652839;669153;670090;686510;130081;131853;132046;132173;133082.33458832838;958.7794807194384;1016.202281209262;1027.465717826726;1068.4070340960686;1077.1113831089383;18621.627567448304;19001.954892481048;19489.86722571662;19912.70130948008;20139.79860201379;53597.73201134126;54513.727431364176;55588.610284743205;55652.443475566346;58262.708686456295;68925;74059.25940740739;79920.60039699764;81134.59432702798;81318;8009.639566219651;8367.74896753074;8399.622017009127;8506.61720222579;8672.176143266379;12030.338331391507;12570.874291257336;12659.746805064031;12700.809487857505;12756.298403587893;9065.41074830134;10822.458877055959;11157.330560166416;11263.211575189658;11326.093912486816;10758.73103172427;10823.512941917475;10922.235443518877;11300.434978251218;11325.433728313716;10731.570737170427;11212.831807523056;11367.772644546898;11631.95312421886;11649.941750291195;8221.671133154607;8394.244517993166;8447.028591711785;8467.872981905399;8558.27254683334;11081.5567377304;11227.831582526105;11377.943110284396;11393.860613938872;11445.942770286096 14:46:11 INFO - PROCESS | 2378 | |3;mootools.html;1531.356830131345;1627.4873414874314;1853.9258429662814;1950.1029526417847;1998.960020799585;6756.2568117507035;8806.823863522743;8877.334199935007;9102.180803727662;9117.544122793866;8907.554622268894;8972;9092.727218183449;9098.31762617803;9138.497382643953;2535.1633960792988;2545.5672535668887;2562.064846331085;2574.485102979402;2578.0718941181253;2522.646829443879;2577.2010676690193;2580.419405633736;2584.082650659017;2584.3539115221197;2557.9616305755335;2558.60341647045;2559.398541342783;2582.3415029167536;2590.9870450647722;2500.4124030852827;2506.862122583257;2514.6102354135137;2517;2536.4293034067373;2513.296277042431;2535.657686212356;2552.0302285131716;2558.910438134675;2588.3658503666534;9099.090090990914;9171.037041110721;9174.67888623895;9186.86219706705;9194.816103677957;5577.832665020056;5610.971945140289;5667.263255776764;5669.376368599451;5760.193572899798;3573.0531409176588;3678.9698884312434;3727.2918145552258;3734.0851491384515;3746.7002639788752;913.4427998920653;1041.9736559488972;1060.112761057728;1081.5998080710108;1083.4907593431153;10675.946620266926;11970.880291197063;12360.690982725413;12363.505459781598;12391.690207744788;4806.7836947337455;4920.138975679241;4986.6010719143105;5011.348524691767;5084.8220312288895;8739.951205855337;8803.691870784492;10088.142507886765;10481.42352170638;10606.734831629272;5596.664200148004;5607.579431542651;5712.514436272881;5723.656580605177;5729.885402292014;4591.586757191802;4967.3294105296045;5011.649184557046;5046.091703493333;5085.186370180827;4234.428352172417;4253.63844073251;4292.18448494785;4328.523862375137;4357.128574285156;1360.5374172781103;1391.5755694513068;1391.9560329752685;1399.5451478269604;1400.2298735695326;862.4394143806576;929.5538141692026;943.8018016216535;986.3982970388057;989.8069876374182;6074.787382441682;6152.077188421773;6254.749810007549;6269.059641053787;6276.843078923063;413.7600191888697;458.6674660870909;477.9665423420327;478.08446824331014;478.6266711964673;3479.3737127317327;4126.546079931205;4138.689598280141;4170.874873753793;4174.833006679699;9219.44683319003;10873.619423320146;11242.213045086928;11277.097832173406;11411.25826821254;10572.101371383518;10787.406692631981;10848.349099054081;10851.294665846852;11100.94541018602;8505.914940850636;8538.18887205727;8542.829143417097;8589.26991205742;8795.912040879637;5908.734106965111;5912.320083190488;5916.49709774674;6081.726322315418;6148.78479253224;9786.363886347364;9887.862895767079;10014.849777253492;10020.198384129399;10076.294659373774;9959;10240.692779216635;10268.537915793659;10307.072363487323;10320.277580569287;6971.198312194163;7366.7053317866685;7536.660850261861;7755.340796032175;7759.146493885781;8469.74590762278;8523.829523409373;8528.573571321285;8541.743747687578;8587.699430519902;7505.286997735207;7609.543427394374;7706.922930770621;7712.807179820549;7742.845143097219;7447.404207663266;7536.7362142324755;7542.962285188539;7620.961895190489;7641.465097443348;7149.9285007149265;7157;7159.319864612853;7215.134183897966;7297.306755858185;4964.05682920244;4974.8756281093265;5100.158473851773;5143;5155.793768249228;5059.620528460307;5104.387473503203;5130.58955283569;5206.323177986837;5319.707416092152 14:46:11 INFO - PROCESS | 2378 | |4;prototype.html;257.93809485723426;332.4099722991691;334.55337124938217;338.56325340311;347.5533938888529;6991.650417479124;6994.930050699491;7037.7536786212495;7068.929310706892;7097.538659987097;6983.930160698392;6993;7005;7007.334303241197;7050.506464547484;4896.5593096621205;4959.156943319626;5082.2376643503585;5090.770915308802;5115.207142892839;5030.220315851049;5067.467915868836;5075.9746201268945;5080.2379643053655;5106.897862042757;4965.652404331699;5028.396592408898;5043.974780126095;5058.0895438821;5089.974550127245;5032.949670503284;5054.570361519275;5065.848024559251;5090.236464530313;5136;3867.323218436762;4019.738716983387;4356.106998065421;4361.847335343279;4374.081442896995;6369.617822930592;6609.272979972199;6671.93328066718;6718.731250749964;6754.358335958076;5961.615353858448;5978.073398623177;6026.337102918676;6032.185654936571;6035.486983606354;6016.939830601682;6148.8770224595255;7536.962315188443;7562.281583249583;7563.319301262913;4963.478834722375;4964.205727083649;4965.553100220961;4965.826196083156;4987.5511203991455;5622.381538030813;7563.924360756377;7725.5364678119495;7929.365650747926;7948.165442628499;4776.976115119472;4817.8313759018265;4860.80556777732;4861.975690121527;4869.9269510957365;4926.285688575136;4926.8275610354185;4931.679440836334;4941.407031156285;4949.90100197994;5917.289925209003;5963.701814909324;5979.611325263844;5990.460858522754;5993.130996005555;6024.457798798129;7432.62836858155;7450.813729656694;7463.477556571096;7468.663910123949;1735.947921562355;1795.3895675470142;1809.9819001810076;1811.221174894808;1812.2932056497975;1145.484531960621;1155.5089087137933;1162.5466068233395;1164.574930150489;1165.114512970132;6989;7047.964760176166;7084.326988936043;7121.608311542811;7127.7148914042855;6821.420179284816;7280.199178090405;7519.135299440634;7691.077070751546;7807.336376408069;7080.92919070813;7129.572225666477;7162.606056666829;7182.209956904736;7201.675924583406;4157.729747566398;4186.602272784081;4202.096549241927;4211.7262377945335;4213.304804707251;8227.588620568948;8246.54643994586;8252.793680157924;8275.83448331042;8277.172282771675;5362.463753624685;8094.83810323802;8109.270165685117;8139.30815880645;8196.877046844302;7896;8191.631376588187;8191.83616327682;8202.38482113844;8243.381746369047;6686.966565167143;7872.527648341118;7895.526268423913;7917.524948503108;7942.880856787037;7440.404767618686;7716.498427602188;7719.3052625264;7729.574873382018;7755.108162561152;6161.507079433724;7513.361364284097;7808.960955195188;8229.177082291722;8262.843201951611;5090.440051594248;5106.591472682102;5115.437301896863;5119.87200319995;5135.6918584885025;7114.501984861217;7198.316159964795;7866.410019248694;7886.881696774438;7899.447038707235;6074.817755467343;7252.89120663201;7565.735199268;7588;7602.923970760222;7447.180810110992;7483.850322993619;7493.850122997618;7529.435292353205;7654;7355.227701091522;7388.889166662612;7391.963040184764;7407.888881666887;7411.0736157980255;7538.208488108669;7553.206913274247;7569.810754731176;7583.27958843909;7606.125295591078;7144.3212894774915;7362.9631851840395;7372.447066469929;7385.372243359375;7398.815029624302 14:46:11 INFO - PROCESS | 2378 | |5;yui.html;740.5704691279059;764.2968469008512;766.6665000724681;792.3502727763233;794.4399198565012;15199.316030778615;15520.456784012562;15576.454824081131;15577;15610.531684049483;14313.998020138595;14346.641333966656;14357;14363.64090897728;14409.135451872895;755.490044220152;921.9216366608813;931.2456909902984;954.6563237234625;955.2644463762898;944.9291303152256;959.6209497248617;961.6634178037701;962.427355723347;965.1988849255137;990.3117333453253;1008.0826447932383;1009.6920439266021;1011.2870426349406;1014.5383850348074;972.6255391674185;986.8717066781309;1001.0390025575383;1008.2790804574728;1009.1018993096151;737.8856277277031;749.6626518066837;755.4938191411767;758.8330567275191;759.1307952394533;12446.626601201979;15008.699826003418;15164.469243576423;15282.694346113127;15336.15651139187;13182.802257966137;13216.801747973788;13217.5460699323;13226.074174807767;13381.19712817234;9998.80002399948;10247.180225581935;10267.845982310271;10289.22830787694;10322.329048611817;3601.963980360189;3612.0789198754414;3726.4782930389765;3739.476473293741;3851.480050193216;55078.72460637711;85434;85808.57095714544;87756.56121719415;88898.66652000225;9418.717438476857;9527.681643743173;9684.661036863818;9778.951105244429;9786.804263914682;21036.684449733268;21632.35102946914;21657.891710541346;21660.56678866414;21714.348569542937;6229.56393052482;7380.077490313711;7540.095188577406;7550.320471157622;7599.772006839804;3994.9201015979515;4119.279126152911;4227.725197862129;4229.069604686964;4303.956960430356;3140.3719256148406;3182.6499085100622;3756.0609847538117;3802.2775672622115;3821.121142137324;610.6793933185024;631.2866460899246;631.9778807741707;632.4402903430497;632.8924082905917;589.7581991383512;601.3475379213514;607.8723468071667;610.9633421994695;619.4332186049804;8221.954017850434;8275.08974012858;8361.205685459872;8547.40168188221;8569.185927336894;530.5145791600719;596.7434003378502;598.2133494454778;608.4797498139116;620.3548309757801;3900.7854567998465;3971.8014099295497;3973.384125460558;4005.018770401212;4039.1921615676983;94071;94445;95956.52021739847;96357.51821240848;96364;71350;72267;73343.53312933818;73510.6324468385;74636;71208;71214;71551.6422417895;72379.19052023636;72903.54192916218;7219.061522002106;7757.379409647102;7775.650095745818;7847.921520784719;8195;50942.74528627333;51321.486785133166;51601.48398515967;52457.21314180214;52678;67664;68986.65506672635;70733.64633176802;70860.29139708537;71028.93456598259;9963.083085476752;10036.046575575308;10260.58957641686;10275.434851082962;10360.912104228948;10907.781844363228;11102.944485277521;11966.940165299118;12107.273563586214;12543.686407839878;11421.885781142415;11529.250598711056;11586.36275004849;11626.76746465083;11884.168108232341;10318.948405257926;11574.594889178838;11651;11860.525578976743;12055;11297.491612877277;11421.657350279505;11592.826107608224;11707.239029463057;11836.881631183578;9686.225101991964;9842.79896224518;9982.800343992934;10041.196704263788;10150.49247537635;9849.60601575929;10006.749831254278;10042.94978525132;10073.899261007296;10077 14:46:11 INFO - PROCESS | 2378 | __end_tp_report 14:46:11 INFO - PROCESS | 2378 | __start_cc_report 14:46:11 INFO - PROCESS | 2378 | _x_x_mozilla_cycle_collect,393 14:46:11 INFO - PROCESS | 2378 | __end_cc_report 14:46:11 INFO - PROCESS | 2378 | __startTimestamp1467236771021__endTimestamp 14:46:11 INFO - PROCESS | 2378 | 14:46:11 INFO - PROCESS | 2378 | ------- Summary: start ------- 14:46:11 INFO - PROCESS | 2378 | Number of tests: 6 14:46:11 INFO - PROCESS | 2378 | 14:46:11 INFO - PROCESS | 2378 | [#0] dojo.html Cycles:165 Average:5912.02 Median:6130.60 stddev:637.62 (10.4%) stddev-sans-first:613.10 14:46:11 INFO - PROCESS | 2378 | Values: 3594.0 3602.4 3622.0 3631.8 3677.6 5868.2 5889.2 5898.9 5914.2 5948.4 5832.9 5934.2 5946.3 5977.4 5981.9 5289.4 5297.9 5348.1 5386.2 5433.3 5330.5 5421.8 5430.4 5438.5 5511.2 5426.0 5435.7 5439.5 5468.4 5471.7 5353.5 5396.3 5413.0 5431.6 5442.1 5318.3 5342.9 5434.3 5445.5 5474.8 5815.2 5828.6 5861.0 5878.2 5891.2 6191.5 6211.6 6239.8 6280.3 6295.2 6387.5 6398.7 6406.4 6412.8 6425.6 6123.1 6128.7 6135.0 6140.5 6159.4 5384.6 6354.2 6454.2 6464.3 6543.5 5365.9 6123.4 6284.2 6326.0 6336.1 6482.1 6491.5 6498.0 6501.5 6504.5 5246.7 6216.9 6336.4 6342.3 6382.6 6333.3 6363.2 6366.5 6376.2 6379.8 5024.6 5037.6 5058.9 5137.9 5156.3 4558.2 4572.2 4607.8 4623.3 4658.9 4914.8 6106.1 6106.8 6122.7 6132.0 6198.8 6357.2 6411.5 6478.9 6483.0 5963.7 6032.6 6095.8 6114.3 6141.6 5568.7 5569.1 5578.2 5599.1 5610.4 6507.6 6551.0 6619.8 6623.4 6653.3 5168.8 6401.1 6409.1 6433.8 6473.6 6622.0 6651.3 6671.6 6674.1 6693.0 6206.5 6245.2 6326.0 6340.0 6375.6 6414.9 6439.5 6451.6 6465.7 6466.7 6094.4 6180.8 6238.4 6239.5 6252.4 6110.1 6130.6 6159.5 6181.3 6190.4 6033.3 6104.6 6143.7 6153.3 6179.5 6100.6 6263.9 6274.6 6279.0 6279.9 6118.1 6122.6 6150.8 6206.2 6219.9 14:46:11 INFO - PROCESS | 2378 | 14:46:11 INFO - PROCESS | 2378 | [#1] ext.html Cycles:180 Average:68159.83 Median:38989.11 stddev:148979.66 (382.1%) stddev-sans-first:149311.12 14:46:11 INFO - PROCESS | 2378 | Values: 555.2 562.8 581.1 609.9 614.5 28402.6 33990.8 37559.9 38826.8 41623.8 38735.3 39815.8 43425.3 43731.6 44228.3 9001.4 9171.2 9603.2 9794.3 9873.1 9722.3 9806.8 9815.7 9890.5 9896.1 8176.5 8431.7 9812.7 9813.4 9884.9 8297.4 9797.4 9819.8 9850.1 9911.7 8527.8 9675.7 9690.1 9734.5 9825.8 40144.6 40572.6 41117.4 41194.4 41225.6 3271.7 3333.1 3379.4 3419.2 3420.7 28791.4 29306.3 29314.7 29557.1 29670.9 2715.0 2784.5 2794.1 2823.6 2828.3 443557.0 444556.0 445107.0 446202.0 446262.0 37733.4 38198.2 62543.0 62654.7 62982.0 36384.5 36540.0 36737.8 36757.3 36768.1 15994.3 16086.4 16174.2 16204.4 16415.3 13667.8 13680.7 13707.7 13752.2 13872.0 8382.9 8386.1 8482.2 8539.2 8547.1 3550.1 3558.4 3590.1 3622.8 3632.5 1052.4 1065.0 1072.3 1084.7 1086.7 27989.4 29162.1 30717.5 30820.0 31131.7 1144.6 1163.8 1165.5 1228.7 1234.9 12162.6 13879.7 15570.8 15627.5 15716.6 507639.0 581368.0 648433.0 652267.0 660437.0 59841.7 61714.4 63046.1 63178.0 63239.1 1526.9 1542.4 1552.5 1564.0 1570.2 24038.0 29947.3 30111.4 30672.5 30729.0 53515.0 61600.7 63492.4 64335.4 65233.7 551160.0 580063.0 617443.0 617692.0 618433.0 41464.6 42650.6 43057.6 44135.3 44271.8 47231.3 47972.5 48507.8 48871.5 48915.3 37897.8 38639.8 39082.0 39228.8 39265.0 38247.0 38273.2 38501.8 38630.4 38896.2 35789.8 38753.6 39328.6 39506.8 40083.4 31968.8 32772.8 33694.5 35050.8 35179.5 24913.5 25060.7 25087.2 25314.5 25481.0 14:46:11 INFO - PROCESS | 2378 | 14:46:11 INFO - PROCESS | 2378 | [#2] jquery.html Cycles:180 Average:36068.47 Median:21778.40 stddev:107638.86 (494.2%) stddev-sans-first:107907.52 14:46:11 INFO - PROCESS | 2378 | Values: 414.7 417.2 417.7 421.4 427.7 20879.4 21003.3 21371.1 21655.4 21680.0 21301.3 21572.6 21669.3 21901.7 21907.9 5888.8 6329.5 6332.7 6333.9 6353.3 4551.0 6252.1 6298.1 6375.6 6392.4 5922.4 6110.4 6135.9 6245.9 6248.3 5804.8 6137.0 6196.2 6925.9 7055.9 6184.4 6184.8 6187.8 6214.3 6238.3 20027.7 25462.7 26091.0 26167.0 26673.9 2170.6 2258.5 2315.6 2351.3 2368.1 10059.4 10081.7 10182.8 10553.9 10774.4 1812.6 1819.8 1830.3 1858.0 1873.0 76539.6 78264.2 79277.6 105343.0 108559.5 11744.2 11893.0 12278.1 12293.5 12354.3 15444.9 15737.8 15775.1 15800.8 15895.5 9544.5 9596.5 9598.3 9666.6 9756.0 9557.0 9679.2 9684.6 9685.4 9711.6 4903.6 4928.7 4967.5 5003.8 5020.8 2050.4 2084.3 2089.2 2097.7 2098.8 927.5 982.6 1001.8 1039.9 1054.3 17636.7 19778.7 21249.7 21775.3 21781.5 970.6 1001.8 1032.3 1054.9 1072.6 10215.6 10959.5 11184.6 11365.1 11574.9 565302.0 652839.0 669153.0 670090.0 686510.0 130081.0 131853.0 132046.0 132173.0 133082.3 958.8 1016.2 1027.5 1068.4 1077.1 18621.6 19002.0 19489.9 19912.7 20139.8 53597.7 54513.7 55588.6 55652.4 58262.7 68925.0 74059.3 79920.6 81134.6 81318.0 8009.6 8367.7 8399.6 8506.6 8672.2 12030.3 12570.9 12659.7 12700.8 12756.3 9065.4 10822.5 11157.3 11263.2 11326.1 10758.7 10823.5 10922.2 11300.4 11325.4 10731.6 11212.8 11367.8 11632.0 11649.9 8221.7 8394.2 8447.0 8467.9 8558.3 11081.6 11227.8 11377.9 11393.9 11445.9 14:46:11 INFO - PROCESS | 2378 | 14:46:11 INFO - PROCESS | 2378 | [#3] mootools.html Cycles:180 Average:5869.79 Median:5011.50 stddev:3235.43 (64.6%) stddev-sans-first:3228.08 14:46:11 INFO - PROCESS | 2378 | Values: 1531.4 1627.5 1853.9 1950.1 1999.0 6756.3 8806.8 8877.3 9102.2 9117.5 8907.6 8972.0 9092.7 9098.3 9138.5 2535.2 2545.6 2562.1 2574.5 2578.1 2522.6 2577.2 2580.4 2584.1 2584.4 2558.0 2558.6 2559.4 2582.3 2591.0 2500.4 2506.9 2514.6 2517.0 2536.4 2513.3 2535.7 2552.0 2558.9 2588.4 9099.1 9171.0 9174.7 9186.9 9194.8 5577.8 5611.0 5667.3 5669.4 5760.2 3573.1 3679.0 3727.3 3734.1 3746.7 913.4 1042.0 1060.1 1081.6 1083.5 10675.9 11970.9 12360.7 12363.5 12391.7 4806.8 4920.1 4986.6 5011.3 5084.8 8740.0 8803.7 10088.1 10481.4 10606.7 5596.7 5607.6 5712.5 5723.7 5729.9 4591.6 4967.3 5011.6 5046.1 5085.2 4234.4 4253.6 4292.2 4328.5 4357.1 1360.5 1391.6 1392.0 1399.5 1400.2 862.4 929.6 943.8 986.4 989.8 6074.8 6152.1 6254.7 6269.1 6276.8 413.8 458.7 478.0 478.1 478.6 3479.4 4126.5 4138.7 4170.9 4174.8 9219.4 10873.6 11242.2 11277.1 11411.3 10572.1 10787.4 10848.3 10851.3 11100.9 8505.9 8538.2 8542.8 8589.3 8795.9 5908.7 5912.3 5916.5 6081.7 6148.8 9786.4 9887.9 10014.8 10020.2 10076.3 9959.0 10240.7 10268.5 10307.1 10320.3 6971.2 7366.7 7536.7 7755.3 7759.1 8469.7 8523.8 8528.6 8541.7 8587.7 7505.3 7609.5 7706.9 7712.8 7742.8 7447.4 7536.7 7543.0 7621.0 7641.5 7149.9 7157.0 7159.3 7215.1 7297.3 4964.1 4974.9 5100.2 5143.0 5155.8 5059.6 5104.4 5130.6 5206.3 5319.7 14:46:11 INFO - PROCESS | 2378 | 14:46:11 INFO - PROCESS | 2378 | [#4] prototype.html Cycles:180 Average:6084.96 Median:6990.33 stddev:1948.32 (27.9%) stddev-sans-first:1904.06 14:46:11 INFO - PROCESS | 2378 | Values: 257.9 332.4 334.6 338.6 347.6 6991.7 6994.9 7037.8 7068.9 7097.5 6983.9 6993.0 7005.0 7007.3 7050.5 4896.6 4959.2 5082.2 5090.8 5115.2 5030.2 5067.5 5076.0 5080.2 5106.9 4965.7 5028.4 5044.0 5058.1 5090.0 5032.9 5054.6 5065.8 5090.2 5136.0 3867.3 4019.7 4356.1 4361.8 4374.1 6369.6 6609.3 6671.9 6718.7 6754.4 5961.6 5978.1 6026.3 6032.2 6035.5 6016.9 6148.9 7537.0 7562.3 7563.3 4963.5 4964.2 4965.6 4965.8 4987.6 5622.4 7563.9 7725.5 7929.4 7948.2 4777.0 4817.8 4860.8 4862.0 4869.9 4926.3 4926.8 4931.7 4941.4 4949.9 5917.3 5963.7 5979.6 5990.5 5993.1 6024.5 7432.6 7450.8 7463.5 7468.7 1735.9 1795.4 1810.0 1811.2 1812.3 1145.5 1155.5 1162.5 1164.6 1165.1 6989.0 7048.0 7084.3 7121.6 7127.7 6821.4 7280.2 7519.1 7691.1 7807.3 7080.9 7129.6 7162.6 7182.2 7201.7 4157.7 4186.6 4202.1 4211.7 4213.3 8227.6 8246.5 8252.8 8275.8 8277.2 5362.5 8094.8 8109.3 8139.3 8196.9 7896.0 8191.6 8191.8 8202.4 8243.4 6687.0 7872.5 7895.5 7917.5 7942.9 7440.4 7716.5 7719.3 7729.6 7755.1 6161.5 7513.4 7809.0 8229.2 8262.8 5090.4 5106.6 5115.4 5119.9 5135.7 7114.5 7198.3 7866.4 7886.9 7899.4 6074.8 7252.9 7565.7 7588.0 7602.9 7447.2 7483.9 7493.9 7529.4 7654.0 7355.2 7388.9 7392.0 7407.9 7411.1 7538.2 7553.2 7569.8 7583.3 7606.1 7144.3 7363.0 7372.4 7385.4 7398.8 14:46:11 INFO - PROCESS | 2378 | 14:46:11 INFO - PROCESS | 2378 | [#5] yui.html Cycles:180 Average:18451.93 Median:26604.26 stddev:25980.40 (97.7%) stddev-sans-first:26019.24 14:46:11 INFO - PROCESS | 2378 | Values: 740.6 764.3 766.7 792.4 794.4 15199.3 15520.5 15576.5 15577.0 15610.5 14314.0 14346.6 14357.0 14363.6 14409.1 755.5 921.9 931.2 954.7 955.3 944.9 959.6 961.7 962.4 965.2 990.3 1008.1 1009.7 1011.3 1014.5 972.6 986.9 1001.0 1008.3 1009.1 737.9 749.7 755.5 758.8 759.1 12446.6 15008.7 15164.5 15282.7 15336.2 13182.8 13216.8 13217.5 13226.1 13381.2 9998.8 10247.2 10267.8 10289.2 10322.3 3602.0 3612.1 3726.5 3739.5 3851.5 55078.7 85434.0 85808.6 87756.6 88898.7 9418.7 9527.7 9684.7 9779.0 9786.8 21036.7 21632.4 21657.9 21660.6 21714.3 6229.6 7380.1 7540.1 7550.3 7599.8 3994.9 4119.3 4227.7 4229.1 4304.0 3140.4 3182.6 3756.1 3802.3 3821.1 610.7 631.3 632.0 632.4 632.9 589.8 601.3 607.9 611.0 619.4 8222.0 8275.1 8361.2 8547.4 8569.2 530.5 596.7 598.2 608.5 620.4 3900.8 3971.8 3973.4 4005.0 4039.2 94071.0 94445.0 95956.5 96357.5 96364.0 71350.0 72267.0 73343.5 73510.6 74636.0 71208.0 71214.0 71551.6 72379.2 72903.5 7219.1 7757.4 7775.7 7847.9 8195.0 50942.7 51321.5 51601.5 52457.2 52678.0 67664.0 68986.7 70733.6 70860.3 71028.9 9963.1 10036.0 10260.6 10275.4 10360.9 10907.8 11102.9 11966.9 12107.3 12543.7 11421.9 11529.3 11586.4 11626.8 11884.2 10318.9 11574.6 11651.0 11860.5 12055.0 11297.5 11421.7 11592.8 11707.2 11836.9 9686.2 9842.8 9982.8 10041.2 10150.5 9849.6 10006.7 10042.9 10073.9 10077.0 14:46:11 INFO - PROCESS | 2378 | -------- Summary: end -------- 14:46:11 INFO - PROCESS | 2378 | 14:46:11 INFO - TEST-INFO | 2378: exit 0 14:46:11 INFO - TEST-OK | dromaeo_css | took 1110138ms 14:46:11 INFO - TEST-START | kraken 14:46:11 INFO - operating with platform_type : mac_ 14:46:11 INFO - Initialising browser for kraken test... 14:46:11 INFO - TEST-INFO | started process 2383 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpejcwGs/profile http://localhost:57385/getInfo.html) 14:46:14 INFO - PROCESS | 2383 | __metrics Screen width/height:1600/1200 14:46:14 INFO - PROCESS | 2383 | colorDepth:24 14:46:14 INFO - PROCESS | 2383 | Browser inner width/height: 1024/689 14:46:14 INFO - PROCESS | 2383 | __metrics 14:46:14 ERROR - PROCESS | 2383 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 14:46:14 INFO - TEST-INFO | 2383: exit 0 14:46:14 INFO - Browser initialized. 14:46:14 INFO - Running cycle 1/1 for kraken test... 14:46:14 INFO - TEST-INFO | started process 2387 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpejcwGs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:46:26 INFO - PROCESS | 2387 | RSS: Main: 171180032 14:46:26 INFO - PROCESS | 2387 | 14:46:29 INFO - PROCESS | 2387 | Cycle 1(1): loaded http://localhost:57385/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57385/tests/kraken/driver.html?testName=audio-beat-detection) 14:46:30 INFO - PROCESS | 2387 | RSS: Main: 183595008 14:46:30 INFO - PROCESS | 2387 | 14:46:32 INFO - PROCESS | 2387 | Cycle 1(1): loaded http://localhost:57385/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57385/tests/kraken/driver.html?testName=audio-dft) 14:46:33 INFO - PROCESS | 2387 | RSS: Main: 192204800 14:46:33 INFO - PROCESS | 2387 | 14:46:36 INFO - PROCESS | 2387 | Cycle 1(1): loaded http://localhost:57385/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57385/tests/kraken/driver.html?testName=audio-fft) 14:46:37 INFO - PROCESS | 2387 | RSS: Main: 196288512 14:46:37 INFO - PROCESS | 2387 | 14:46:39 INFO - PROCESS | 2387 | Cycle 1(1): loaded http://localhost:57385/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57385/tests/kraken/driver.html?testName=audio-oscillator) 14:46:39 INFO - PROCESS | 2387 | RSS: Main: 196521984 14:46:39 INFO - PROCESS | 2387 | 14:46:42 INFO - PROCESS | 2387 | Cycle 1(1): loaded http://localhost:57385/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57385/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:46:42 INFO - PROCESS | 2387 | RSS: Main: 196395008 14:46:42 INFO - PROCESS | 2387 | 14:46:45 INFO - PROCESS | 2387 | Cycle 1(1): loaded http://localhost:57385/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57385/tests/kraken/driver.html?testName=imaging-darkroom) 14:46:46 INFO - PROCESS | 2387 | RSS: Main: 197120000 14:46:46 INFO - PROCESS | 2387 | 14:46:49 INFO - PROCESS | 2387 | Cycle 1(1): loaded http://localhost:57385/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57385/tests/kraken/driver.html?testName=imaging-desaturate) 14:46:49 INFO - PROCESS | 2387 | RSS: Main: 196878336 14:46:49 INFO - PROCESS | 2387 | 14:46:52 INFO - PROCESS | 2387 | Cycle 1(1): loaded http://localhost:57385/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57385/tests/kraken/driver.html?testName=json-parse-financial) 14:46:53 INFO - PROCESS | 2387 | RSS: Main: 197169152 14:46:53 INFO - PROCESS | 2387 | 14:46:54 INFO - PROCESS | 2387 | Cycle 1(1): loaded http://localhost:57385/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57385/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:46:55 INFO - PROCESS | 2387 | RSS: Main: 197644288 14:46:55 INFO - PROCESS | 2387 | 14:46:57 INFO - PROCESS | 2387 | Cycle 1(1): loaded http://localhost:57385/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57385/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:46:57 INFO - PROCESS | 2387 | RSS: Main: 197758976 14:46:57 INFO - PROCESS | 2387 | 14:46:59 INFO - PROCESS | 2387 | Cycle 1(1): loaded http://localhost:57385/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57385/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:47:00 INFO - PROCESS | 2387 | RSS: Main: 197935104 14:47:00 INFO - PROCESS | 2387 | 14:47:03 INFO - PROCESS | 2387 | Cycle 1(1): loaded http://localhost:57385/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57385/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:47:04 INFO - PROCESS | 2387 | RSS: Main: 198148096 14:47:04 INFO - PROCESS | 2387 | 14:47:06 INFO - PROCESS | 2387 | Cycle 1(1): loaded http://localhost:57385/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57385/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:47:07 INFO - PROCESS | 2387 | RSS: Main: 198139904 14:47:07 INFO - PROCESS | 2387 | 14:47:09 INFO - PROCESS | 2387 | Cycle 1(1): loaded http://localhost:57385/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57385/tests/kraken/driver.html?testName=ai-astar) 14:47:09 INFO - PROCESS | 2387 | RSS: Main: 200167424 14:47:09 INFO - PROCESS | 2387 | 14:47:09 INFO - PROCESS | 2387 | __start_tp_report 14:47:09 INFO - PROCESS | 2387 | _x_x_mozilla_page_load 14:47:09 INFO - PROCESS | 2387 | _x_x_mozilla_page_load_details 14:47:09 INFO - PROCESS | 2387 | |i|pagename|runs| 14:47:09 INFO - PROCESS | 2387 | |0;ai-astar;116;110;115;117;116;132;114;115;116;117 14:47:09 INFO - PROCESS | 2387 | |1;audio-beat-detection;154;122;161;197;147;140;121;165;149;149 14:47:09 INFO - PROCESS | 2387 | |2;audio-dft;195;198;198;195;200;196;196;194;210;197 14:47:09 INFO - PROCESS | 2387 | |3;audio-fft;65;77;74;145;55;116;88;65;125;59 14:47:09 INFO - PROCESS | 2387 | |4;audio-oscillator;77;81;125;61;93;149;161;116;106;162 14:47:09 INFO - PROCESS | 2387 | |5;imaging-gaussian-blur;88;106;89;86;89;85;90;87;90;85 14:47:09 INFO - PROCESS | 2387 | |6;imaging-darkroom;93;97;103;104;152;149;112;93;94;94 14:47:09 INFO - PROCESS | 2387 | |7;imaging-desaturate;89;91;105;127;90;85;142;149;87;91 14:47:09 INFO - PROCESS | 2387 | |8;json-parse-financial;59;63;64;64;64;65;64;78;63;59 14:47:09 INFO - PROCESS | 2387 | |9;json-stringify-tinderbox;61;64;70;66;76;70;70;61;65;67 14:47:09 INFO - PROCESS | 2387 | |10;stanford-crypto-aes;80;81;80;82;89;80;81;80;78;82 14:47:09 INFO - PROCESS | 2387 | |11;stanford-crypto-ccm;142;140;142;145;123;140;142;138;172;176 14:47:09 INFO - PROCESS | 2387 | |12;stanford-crypto-pbkdf2;166;167;169;165;164;164;160;163;226;217 14:47:09 INFO - PROCESS | 2387 | |13;stanford-crypto-sha256-iterative;67;69;95;67;65;97;95;95;76;60 14:47:09 INFO - PROCESS | 2387 | __end_tp_report 14:47:09 INFO - PROCESS | 2387 | __start_cc_report 14:47:09 INFO - PROCESS | 2387 | _x_x_mozilla_cycle_collect,1041 14:47:09 INFO - PROCESS | 2387 | __end_cc_report 14:47:09 INFO - PROCESS | 2387 | __startTimestamp1467236829589__endTimestamp 14:47:09 INFO - PROCESS | 2387 | 14:47:09 INFO - PROCESS | 2387 | ------- Summary: start ------- 14:47:09 INFO - PROCESS | 2387 | Number of tests: 14 14:47:09 INFO - PROCESS | 2387 | 14:47:09 INFO - PROCESS | 2387 | [#0] ai-astar Cycles:10 Average:116.80 Median:116.00 stddev:5.71 (4.9%) stddev-sans-first:6.05 14:47:09 INFO - PROCESS | 2387 | Values: 116.0 110.0 115.0 117.0 116.0 132.0 114.0 115.0 116.0 117.0 14:47:09 INFO - PROCESS | 2387 | 14:47:09 INFO - PROCESS | 2387 | [#1] audio-beat-detection Cycles:10 Average:150.50 Median:151.50 stddev:21.87 (14.4%) stddev-sans-first:23.16 14:47:09 INFO - PROCESS | 2387 | Values: 154.0 122.0 161.0 197.0 147.0 140.0 121.0 165.0 149.0 149.0 14:47:09 INFO - PROCESS | 2387 | 14:47:09 INFO - PROCESS | 2387 | [#2] audio-dft Cycles:10 Average:197.90 Median:197.50 stddev:4.61 (2.3%) stddev-sans-first:4.76 14:47:09 INFO - PROCESS | 2387 | Values: 195.0 198.0 198.0 195.0 200.0 196.0 196.0 194.0 210.0 197.0 14:47:09 INFO - PROCESS | 2387 | 14:47:09 INFO - PROCESS | 2387 | [#3] audio-fft Cycles:10 Average:86.90 Median:65.00 stddev:31.08 (47.8%) stddev-sans-first:31.94 14:47:09 INFO - PROCESS | 2387 | Values: 65.0 77.0 74.0 145.0 55.0 116.0 88.0 65.0 125.0 59.0 14:47:09 INFO - PROCESS | 2387 | 14:47:09 INFO - PROCESS | 2387 | [#4] audio-oscillator Cycles:10 Average:113.10 Median:111.50 stddev:35.94 (32.2%) stddev-sans-first:35.67 14:47:09 INFO - PROCESS | 2387 | Values: 77.0 81.0 125.0 61.0 93.0 149.0 161.0 116.0 106.0 162.0 14:47:09 INFO - PROCESS | 2387 | 14:47:09 INFO - PROCESS | 2387 | [#5] imaging-gaussian-blur Cycles:10 Average:89.50 Median:88.50 stddev:6.10 (6.9%) stddev-sans-first:6.44 14:47:09 INFO - PROCESS | 2387 | Values: 88.0 106.0 89.0 86.0 89.0 85.0 90.0 87.0 90.0 85.0 14:47:09 INFO - PROCESS | 2387 | 14:47:09 INFO - PROCESS | 2387 | [#6] imaging-darkroom Cycles:10 Average:109.10 Median:93.00 stddev:22.67 (24.4%) stddev-sans-first:23.28 14:47:09 INFO - PROCESS | 2387 | Values: 93.0 97.0 103.0 104.0 152.0 149.0 112.0 93.0 94.0 94.0 14:47:09 INFO - PROCESS | 2387 | 14:47:09 INFO - PROCESS | 2387 | [#7] imaging-desaturate Cycles:10 Average:105.60 Median:88.00 stddev:24.45 (27.8%) stddev-sans-first:25.19 14:47:09 INFO - PROCESS | 2387 | Values: 89.0 91.0 105.0 127.0 90.0 85.0 142.0 149.0 87.0 91.0 14:47:09 INFO - PROCESS | 2387 | 14:47:09 INFO - PROCESS | 2387 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:64.00 stddev:5.25 (8.2%) stddev-sans-first:5.21 14:47:09 INFO - PROCESS | 2387 | Values: 59.0 63.0 64.0 64.0 64.0 65.0 64.0 78.0 63.0 59.0 14:47:09 INFO - PROCESS | 2387 | 14:47:09 INFO - PROCESS | 2387 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:68.50 stddev:4.64 (6.8%) stddev-sans-first:4.39 14:47:09 INFO - PROCESS | 2387 | Values: 61.0 64.0 70.0 66.0 76.0 70.0 70.0 61.0 65.0 67.0 14:47:09 INFO - PROCESS | 2387 | 14:47:09 INFO - PROCESS | 2387 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:81.00 stddev:2.95 (3.6%) stddev-sans-first:3.09 14:47:09 INFO - PROCESS | 2387 | Values: 80.0 81.0 80.0 82.0 89.0 80.0 81.0 80.0 78.0 82.0 14:47:09 INFO - PROCESS | 2387 | 14:47:09 INFO - PROCESS | 2387 | [#11] stanford-crypto-ccm Cycles:10 Average:146.00 Median:142.00 stddev:15.95 (11.2%) stddev-sans-first:16.85 14:47:09 INFO - PROCESS | 2387 | Values: 142.0 140.0 142.0 145.0 123.0 140.0 142.0 138.0 172.0 176.0 14:47:09 INFO - PROCESS | 2387 | 14:47:09 INFO - PROCESS | 2387 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.10 Median:166.50 stddev:24.14 (14.5%) stddev-sans-first:25.33 14:47:09 INFO - PROCESS | 2387 | Values: 166.0 167.0 169.0 165.0 164.0 164.0 160.0 163.0 226.0 217.0 14:47:09 INFO - PROCESS | 2387 | 14:47:09 INFO - PROCESS | 2387 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.60 Median:85.50 stddev:15.07 (17.6%) stddev-sans-first:15.39 14:47:09 INFO - PROCESS | 2387 | Values: 67.0 69.0 95.0 67.0 65.0 97.0 95.0 95.0 76.0 60.0 14:47:09 INFO - PROCESS | 2387 | -------- Summary: end -------- 14:47:09 INFO - PROCESS | 2387 | 14:47:10 INFO - TEST-INFO | 2387: exit 0 14:47:10 INFO - TEST-OK | kraken | took 58804ms 14:47:10 INFO - SUITE-END | took 1168s 14:47:10 INFO - Completed test suite (00:19:29) 14:47:10 INFO - javascript benchmark 14:47:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3594.0, 3602.4236122220445, 3622.040159357771, 3631.7639353442023, 3677.6138505456925, 5868.178455016301, 5889.234399528055, 5898.941010589888, 5914.231149950506, 5948.375420580842, 5832.941670583293, 5934.1692163097205, 5946.3161736400325, 5977.3723759005225, 5981.880362392761, 5289.391719952207, 5297.8940421191555, 5348.117560602515, 5386.218998245252, 5433.347998240217, 5330.493603107718, 5421.810236641718, 5430.429804870491, 5438.53772429344, 5511.200875873016, 5426.0, 5435.701036442994, 5439.48324909133, 5468.425815289397, 5471.72641367932, 5353.544948679367, 5396.325459317585, 5412.972935135299, 5431.565474762009, 5442.12925931853, 5318.30861987943, 5342.893142137135, 5434.347878254595, 5445.482679145475, 5474.808381706661, 5815.185873977604, 5828.562857785683, 5861.0, 5878.177055212231, 5891.204687367236, 6191.535634827406, 6211.565190436671, 6239.781607643756, 6280.309165991737, 6295.18162638854, 6387.489000879918, 6398.680065996681, 6406.391392817675, 6412.775552855627, 6425.646589437579, 6123.08153776937, 6128.724207410677, 6134.969325153345, 6140.478059364959, 6159.414855588712, 5384.6499977501335, 6354.17395738551, 6454.160959075384, 6464.321246269168, 6543.476521878239, 5365.946340536622, 6123.357047510036, 6284.214473190851, 6326.0, 6336.144620476269, 6482.092507049017, 6491.480681545465, 6498.0252962056065, 6501.544891857525, 6504.479641628658, 5246.685198888079, 6216.875662486725, 6336.366363363719, 6342.302346741854, 6382.648954307465, 6333.303336633059, 6363.204599425072, 6366.522510811707, 6376.171097757262, 6379.808605741835, 5024.6231532634465, 5037.647364684511, 5058.873528161826, 5137.922931156036, 5156.252343410185, 4558.2251017327135, 4572.245579479349, 4607.792649330788, 4623.306504024423, 4658.86023419298, 4914.827981020647, 6106.053561697944, 6106.816795496142, 6122.693865306717, 6132.0, 6198.752049917953, 6357.1735674362035, 6411.487081033506, 6478.935210647834, 6482.967585162044, 5963.701814909237, 6032.607880487842, 6095.817125486243, 6114.327423983358, 6141.57009009374, 5568.693721845257, 5569.136783798518, 5578.163275508706, 5599.132134519156, 5610.382857885629, 6507.609543427409, 6550.9999999999045, 6619.834504137435, 6623.370779775913, 6653.334666533405, 5168.793248270177, 6401.135846660642, 6409.134766806422, 6433.774817881352, 6473.643949582818, 6621.966890165519, 6651.301613330724, 6671.5997040177745, 6674.065630811788, 6693.0, 6206.503479721521, 6245.156903817927, 6326.0, 6339.96830015847, 6375.6174629522375, 6414.903776443264, 6439.517036222396, 6451.645159516272, 6465.741370345134, 6466.708998095191, 6094.421030002142, 6180.845478862884, 6238.407351301619, 6239.5008399327035, 6252.406021427957, 6110.103144028831, 6130.601510901777, 6159.476444502267, 6181.320054794059, 6190.380961903954, 6033.292287137267, 6104.633721976696, 6143.72353244114, 6153.261608606996, 6179.505639548735, 6100.633961962297, 6263.906041409474, 6274.623522588477, 6278.968605156945, 6279.905801412891, 6118.101457354478, 6122.611623597991, 6150.7847225346895, 6206.224221972254, 6219.906701399573], "value": 5875.032562327608, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.2420945409515, 562.836777334573, 581.1196038002425, 609.8627808743031, 614.450067189865, 28402.573961390597, 33990.83004584977, 37559.87320380386, 38826.8058659707, 41623.79188104055, 38735.25691343889, 39815.80092099535, 43425.34861977065, 43731.562684373144, 44228.336574951405, 9001.414908030989, 9171.220446262076, 9603.183729382994, 9794.314397992144, 9873.111419972201, 9722.319437639368, 9806.803863922718, 9815.65645202418, 9890.456024918627, 9896.059874311964, 8176.509409435424, 8431.747047588582, 9812.656557020506, 9813.362131461432, 9884.85172722406, 8297.419180657356, 9797.363171393836, 9819.803603927918, 9850.113489785917, 9911.653092141813, 8527.829443411098, 9675.70972870815, 9690.12788849007, 9734.513274336327, 9825.820901491796, 40144.59855401438, 40572.59427405718, 41117.38323925144, 41194.38208426876, 41225.58774412277, 3271.7219036381935, 3333.0667413124365, 3379.3629866074634, 3419.230673098558, 3420.6579342065843, 28791.424171516453, 29306.267343316587, 29314.70685293141, 29557.113286601438, 29670.85164574185, 2715.0, 2784.470950519395, 2794.1338185162663, 2823.632927719404, 2828.3494796196783, 443557.0, 444556.0, 445107.0, 446201.99999999674, 446262.0, 37733.43399849004, 38198.23603527914, 62543.0, 62654.68672656608, 62982.0, 36384.45423318652, 36540.0, 36737.81631091881, 36757.26485470329, 36768.08079797973, 15994.280257388446, 16086.43697470583, 16174.19129043543, 16204.351825926831, 16415.343386264416, 13667.794983075262, 13680.726385472235, 13707.725845483234, 13752.243626600633, 13872.0, 8382.916170838214, 8386.119457457002, 8482.151784821592, 8539.231469167804, 8547.059823419419, 3550.0592343029116, 3558.448440491728, 3590.1024743814046, 3622.8188590570894, 3632.54593175853, 1052.4369462337613, 1064.9627263045757, 1072.3325229268407, 1084.6854412220368, 1086.6577028236081, 27989.440211195662, 29162.125136245948, 30717.539236911463, 30820.0, 31131.68868311288, 1144.5879483385975, 1163.761428907072, 1165.522135924284, 1228.7173949991372, 1234.925904445736, 12162.574309899112, 13879.653008674662, 15570.844291557167, 15627.453039143802, 15716.60708482297, 507639.0, 581368.0, 648433.0, 652267.0, 660437.0, 59841.700791495765, 61714.382856170865, 63046.0543091854, 63178.0, 63239.05141422882, 1526.9465568705043, 1542.383046781274, 1552.4876790659055, 1564.0224859462835, 1570.2227397438342, 24038.0, 29947.251318717208, 30111.397772044875, 30672.539911900894, 30729.0, 53515.0, 61600.69199653973, 63492.365076348644, 64335.356646432934, 65233.673831630535, 551160.0, 580063.0, 617443.0, 617692.0, 618433.0, 41464.585354146075, 42650.57349426466, 43057.56942430536, 44135.33796993112, 44271.77864110788, 47231.29153062638, 47972.520274798204, 48507.757461212466, 48871.5112848867, 48915.266271005254, 37897.81051094727, 38639.80680096582, 39082.0, 39228.803855980535, 39265.0, 38247.0, 38273.234535308584, 38501.844944651704, 38630.42054369243, 38896.222075557765, 35789.82105089458, 38753.612463876125, 39328.623498177425, 39506.802465987486, 40083.39874901937, 31968.840155800004, 32772.83613581917, 33694.49458258079, 35050.773222937074, 35179.47230791489, 24913.501729964937, 25060.74939250584, 25087.247382578553, 25314.493710126062, 25481.0], "value": 19215.13596714808, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.71799176559927, 417.18232264761065, 417.6679539765886, 421.3742592250508, 427.7454914325975, 20879.373618791422, 21003.264885729004, 21371.145154193815, 21655.35033948982, 21680.02439890205, 21301.25445609404, 21572.568548629017, 21669.34991950244, 21901.671474927887, 21907.890460547715, 5888.764449422018, 6329.4619957303685, 6332.715027823736, 6333.936660633404, 6353.30113687494, 4550.954490455103, 6252.124702541648, 6298.149749783789, 6375.617462952215, 6392.424681778639, 5922.437368449991, 6110.419510146529, 6135.8772824543485, 6245.937540624604, 6248.343923887995, 5804.796832110877, 6136.999999999977, 6196.225471816023, 6925.896111558331, 7055.8588828223665, 6184.350643182446, 6184.81445556634, 6187.845303867394, 6214.316425193225, 6238.282597501255, 20027.699584506245, 25462.745372546407, 26091.0, 26167.0, 26673.933042678465, 2170.6092903277404, 2258.5144193998367, 2315.5947709150832, 2351.271105957159, 2368.135630494874, 10059.446730429896, 10081.747956301078, 10182.796344073076, 10553.947230263877, 10774.40740759258, 1812.592166762468, 1819.8271164239509, 1830.2587452081796, 1857.9535511612182, 1872.9511473574842, 76539.61730191369, 78264.21735782626, 79277.60361198215, 105343.0, 108559.45720271349, 11744.236624619372, 11893.0, 12278.140530162802, 12293.508259669514, 12354.320512371725, 15444.92277538605, 15737.763933541006, 15775.132367719885, 15800.762988555181, 15895.52313430599, 9544.52277386128, 9596.520173991272, 9598.32811703174, 9666.565004574812, 9756.024397560188, 9557.044295570387, 9679.225661947028, 9684.612615495442, 9685.370450920667, 9711.611535538641, 4903.583195428358, 4928.654994150446, 4967.528084832007, 5003.824866129668, 5020.7740651670765, 2050.4463794775625, 2084.32259515658, 2089.164334266275, 2097.748270207585, 2098.8320934325525, 927.5084205371164, 982.6020461713018, 1001.8246806808925, 1039.9064084232305, 1054.293623272394, 17636.735448968277, 19778.71438356531, 21249.68125478119, 21775.346739597837, 21781.455463613536, 970.5923512124924, 1001.839705647093, 1032.339302846179, 1054.9208809339177, 1072.6245813965206, 10215.642452514126, 10959.50682219302, 11184.608538701106, 11365.09079273656, 11574.88425115755, 565302.0, 652839.0, 669153.0, 670090.0, 686510.0, 130081.0, 131853.0, 132046.0, 132173.0, 133082.33458832838, 958.7794807194384, 1016.202281209262, 1027.465717826726, 1068.4070340960686, 1077.1113831089383, 18621.627567448304, 19001.954892481048, 19489.86722571662, 19912.70130948008, 20139.79860201379, 53597.73201134126, 54513.727431364176, 55588.610284743205, 55652.443475566346, 58262.708686456295, 68925.0, 74059.25940740739, 79920.60039699764, 81134.59432702798, 81318.0, 8009.639566219651, 8367.74896753074, 8399.622017009127, 8506.61720222579, 8672.176143266379, 12030.338331391507, 12570.874291257336, 12659.746805064031, 12700.809487857505, 12756.298403587893, 9065.41074830134, 10822.458877055959, 11157.330560166416, 11263.211575189658, 11326.093912486816, 10758.73103172427, 10823.512941917475, 10922.235443518877, 11300.434978251218, 11325.433728313716, 10731.570737170427, 11212.831807523056, 11367.772644546898, 11631.95312421886, 11649.941750291195, 8221.671133154607, 8394.244517993166, 8447.028591711785, 8467.872981905399, 8558.27254683334, 11081.5567377304, 11227.831582526105, 11377.943110284396, 11393.860613938872, 11445.942770286096], "value": 9910.400897448315, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1531.356830131345, 1627.4873414874314, 1853.9258429662814, 1950.1029526417847, 1998.960020799585, 6756.2568117507035, 8806.823863522743, 8877.334199935007, 9102.180803727662, 9117.544122793866, 8907.554622268894, 8972.0, 9092.727218183449, 9098.31762617803, 9138.497382643953, 2535.1633960792988, 2545.5672535668887, 2562.064846331085, 2574.485102979402, 2578.0718941181253, 2522.646829443879, 2577.2010676690193, 2580.419405633736, 2584.082650659017, 2584.3539115221197, 2557.9616305755335, 2558.60341647045, 2559.398541342783, 2582.3415029167536, 2590.9870450647722, 2500.4124030852827, 2506.862122583257, 2514.6102354135137, 2517.0, 2536.4293034067373, 2513.296277042431, 2535.657686212356, 2552.0302285131716, 2558.910438134675, 2588.3658503666534, 9099.090090990914, 9171.037041110721, 9174.67888623895, 9186.86219706705, 9194.816103677957, 5577.832665020056, 5610.971945140289, 5667.263255776764, 5669.376368599451, 5760.193572899798, 3573.0531409176588, 3678.9698884312434, 3727.2918145552258, 3734.0851491384515, 3746.7002639788752, 913.4427998920653, 1041.9736559488972, 1060.112761057728, 1081.5998080710108, 1083.4907593431153, 10675.946620266926, 11970.880291197063, 12360.690982725413, 12363.505459781598, 12391.690207744788, 4806.7836947337455, 4920.138975679241, 4986.6010719143105, 5011.348524691767, 5084.8220312288895, 8739.951205855337, 8803.691870784492, 10088.142507886765, 10481.42352170638, 10606.734831629272, 5596.664200148004, 5607.579431542651, 5712.514436272881, 5723.656580605177, 5729.885402292014, 4591.586757191802, 4967.3294105296045, 5011.649184557046, 5046.091703493333, 5085.186370180827, 4234.428352172417, 4253.63844073251, 4292.18448494785, 4328.523862375137, 4357.128574285156, 1360.5374172781103, 1391.5755694513068, 1391.9560329752685, 1399.5451478269604, 1400.2298735695326, 862.4394143806576, 929.5538141692026, 943.8018016216535, 986.3982970388057, 989.8069876374182, 6074.787382441682, 6152.077188421773, 6254.749810007549, 6269.059641053787, 6276.843078923063, 413.7600191888697, 458.6674660870909, 477.9665423420327, 478.08446824331014, 478.6266711964673, 3479.3737127317327, 4126.546079931205, 4138.689598280141, 4170.874873753793, 4174.833006679699, 9219.44683319003, 10873.619423320146, 11242.213045086928, 11277.097832173406, 11411.25826821254, 10572.101371383518, 10787.406692631981, 10848.349099054081, 10851.294665846852, 11100.94541018602, 8505.914940850636, 8538.18887205727, 8542.829143417097, 8589.26991205742, 8795.912040879637, 5908.734106965111, 5912.320083190488, 5916.49709774674, 6081.726322315418, 6148.78479253224, 9786.363886347364, 9887.862895767079, 10014.849777253492, 10020.198384129399, 10076.294659373774, 9959.0, 10240.692779216635, 10268.537915793659, 10307.072363487323, 10320.277580569287, 6971.198312194163, 7366.7053317866685, 7536.660850261861, 7755.340796032175, 7759.146493885781, 8469.74590762278, 8523.829523409373, 8528.573571321285, 8541.743747687578, 8587.699430519902, 7505.286997735207, 7609.543427394374, 7706.922930770621, 7712.807179820549, 7742.845143097219, 7447.404207663266, 7536.7362142324755, 7542.962285188539, 7620.961895190489, 7641.465097443348, 7149.9285007149265, 7157.0, 7159.319864612853, 7215.134183897966, 7297.306755858185, 4964.05682920244, 4974.8756281093265, 5100.158473851773, 5143.0, 5155.793768249228, 5059.620528460307, 5104.387473503203, 5130.58955283569, 5206.323177986837, 5319.707416092152], "value": 4678.68048497813, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [257.93809485723426, 332.4099722991691, 334.55337124938217, 338.56325340311, 347.5533938888529, 6991.650417479124, 6994.930050699491, 7037.7536786212495, 7068.929310706892, 7097.538659987097, 6983.930160698392, 6993.0, 7005.0, 7007.334303241197, 7050.506464547484, 4896.5593096621205, 4959.156943319626, 5082.2376643503585, 5090.770915308802, 5115.207142892839, 5030.220315851049, 5067.467915868836, 5075.9746201268945, 5080.2379643053655, 5106.897862042757, 4965.652404331699, 5028.396592408898, 5043.974780126095, 5058.0895438821, 5089.974550127245, 5032.949670503284, 5054.570361519275, 5065.848024559251, 5090.236464530313, 5136.0, 3867.323218436762, 4019.738716983387, 4356.106998065421, 4361.847335343279, 4374.081442896995, 6369.617822930592, 6609.272979972199, 6671.93328066718, 6718.731250749964, 6754.358335958076, 5961.615353858448, 5978.073398623177, 6026.337102918676, 6032.185654936571, 6035.486983606354, 6016.939830601682, 6148.8770224595255, 7536.962315188443, 7562.281583249583, 7563.319301262913, 4963.478834722375, 4964.205727083649, 4965.553100220961, 4965.826196083156, 4987.5511203991455, 5622.381538030813, 7563.924360756377, 7725.5364678119495, 7929.365650747926, 7948.165442628499, 4776.976115119472, 4817.8313759018265, 4860.80556777732, 4861.975690121527, 4869.9269510957365, 4926.285688575136, 4926.8275610354185, 4931.679440836334, 4941.407031156285, 4949.90100197994, 5917.289925209003, 5963.701814909324, 5979.611325263844, 5990.460858522754, 5993.130996005555, 6024.457798798129, 7432.62836858155, 7450.813729656694, 7463.477556571096, 7468.663910123949, 1735.947921562355, 1795.3895675470142, 1809.9819001810076, 1811.221174894808, 1812.2932056497975, 1145.484531960621, 1155.5089087137933, 1162.5466068233395, 1164.574930150489, 1165.114512970132, 6989.0, 7047.964760176166, 7084.326988936043, 7121.608311542811, 7127.7148914042855, 6821.420179284816, 7280.199178090405, 7519.135299440634, 7691.077070751546, 7807.336376408069, 7080.92919070813, 7129.572225666477, 7162.606056666829, 7182.209956904736, 7201.675924583406, 4157.729747566398, 4186.602272784081, 4202.096549241927, 4211.7262377945335, 4213.304804707251, 8227.588620568948, 8246.54643994586, 8252.793680157924, 8275.83448331042, 8277.172282771675, 5362.463753624685, 8094.83810323802, 8109.270165685117, 8139.30815880645, 8196.877046844302, 7896.0, 8191.631376588187, 8191.83616327682, 8202.38482113844, 8243.381746369047, 6686.966565167143, 7872.527648341118, 7895.526268423913, 7917.524948503108, 7942.880856787037, 7440.404767618686, 7716.498427602188, 7719.3052625264, 7729.574873382018, 7755.108162561152, 6161.507079433724, 7513.361364284097, 7808.960955195188, 8229.177082291722, 8262.843201951611, 5090.440051594248, 5106.591472682102, 5115.437301896863, 5119.87200319995, 5135.6918584885025, 7114.501984861217, 7198.316159964795, 7866.410019248694, 7886.881696774438, 7899.447038707235, 6074.817755467343, 7252.89120663201, 7565.735199268, 7588.0, 7602.923970760222, 7447.180810110992, 7483.850322993619, 7493.850122997618, 7529.435292353205, 7654.0, 7355.227701091522, 7388.889166662612, 7391.963040184764, 7407.888881666887, 7411.0736157980255, 7538.208488108669, 7553.206913274247, 7569.810754731176, 7583.27958843909, 7606.125295591078, 7144.3212894774915, 7362.9631851840395, 7372.447066469929, 7385.372243359375, 7398.815029624302], "value": 5433.80597419853, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.5704691279059, 764.2968469008512, 766.6665000724681, 792.3502727763233, 794.4399198565012, 15199.316030778615, 15520.456784012562, 15576.454824081131, 15577.0, 15610.531684049483, 14313.998020138595, 14346.641333966656, 14357.0, 14363.64090897728, 14409.135451872895, 755.490044220152, 921.9216366608813, 931.2456909902984, 954.6563237234625, 955.2644463762898, 944.9291303152256, 959.6209497248617, 961.6634178037701, 962.427355723347, 965.1988849255137, 990.3117333453253, 1008.0826447932383, 1009.6920439266021, 1011.2870426349406, 1014.5383850348074, 972.6255391674185, 986.8717066781309, 1001.0390025575383, 1008.2790804574728, 1009.1018993096151, 737.8856277277031, 749.6626518066837, 755.4938191411767, 758.8330567275191, 759.1307952394533, 12446.626601201979, 15008.699826003418, 15164.469243576423, 15282.694346113127, 15336.15651139187, 13182.802257966137, 13216.801747973788, 13217.5460699323, 13226.074174807767, 13381.19712817234, 9998.80002399948, 10247.180225581935, 10267.845982310271, 10289.22830787694, 10322.329048611817, 3601.963980360189, 3612.0789198754414, 3726.4782930389765, 3739.476473293741, 3851.480050193216, 55078.72460637711, 85434.0, 85808.57095714544, 87756.56121719415, 88898.66652000225, 9418.717438476857, 9527.681643743173, 9684.661036863818, 9778.951105244429, 9786.804263914682, 21036.684449733268, 21632.35102946914, 21657.891710541346, 21660.56678866414, 21714.348569542937, 6229.56393052482, 7380.077490313711, 7540.095188577406, 7550.320471157622, 7599.772006839804, 3994.9201015979515, 4119.279126152911, 4227.725197862129, 4229.069604686964, 4303.956960430356, 3140.3719256148406, 3182.6499085100622, 3756.0609847538117, 3802.2775672622115, 3821.121142137324, 610.6793933185024, 631.2866460899246, 631.9778807741707, 632.4402903430497, 632.8924082905917, 589.7581991383512, 601.3475379213514, 607.8723468071667, 610.9633421994695, 619.4332186049804, 8221.954017850434, 8275.08974012858, 8361.205685459872, 8547.40168188221, 8569.185927336894, 530.5145791600719, 596.7434003378502, 598.2133494454778, 608.4797498139116, 620.3548309757801, 3900.7854567998465, 3971.8014099295497, 3973.384125460558, 4005.018770401212, 4039.1921615676983, 94071.0, 94445.0, 95956.52021739847, 96357.51821240848, 96364.0, 71350.0, 72267.0, 73343.53312933818, 73510.6324468385, 74636.0, 71208.0, 71214.0, 71551.6422417895, 72379.19052023636, 72903.54192916218, 7219.061522002106, 7757.379409647102, 7775.650095745818, 7847.921520784719, 8195.0, 50942.74528627333, 51321.486785133166, 51601.48398515967, 52457.21314180214, 52678.0, 67664.0, 68986.65506672635, 70733.64633176802, 70860.29139708537, 71028.93456598259, 9963.083085476752, 10036.046575575308, 10260.58957641686, 10275.434851082962, 10360.912104228948, 10907.781844363228, 11102.944485277521, 11966.940165299118, 12107.273563586214, 12543.686407839878, 11421.885781142415, 11529.250598711056, 11586.36275004849, 11626.76746465083, 11884.168108232341, 10318.948405257926, 11574.594889178838, 11651.0, 11860.525578976743, 12055.0, 11297.491612877277, 11421.657350279505, 11592.826107608224, 11707.239029463057, 11836.881631183578, 9686.225101991964, 9842.79896224518, 9982.800343992934, 10041.196704263788, 10150.49247537635, 9849.60601575929, 10006.749831254278, 10042.94978525132, 10073.899261007296, 10077.0], "value": 7016.899110543575, "unit": "score"}], "name": "dromaeo_css", "value": 7644.668153780748, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 110.0, 115.0, 117.0, 116.0, 132.0, 114.0, 115.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 122.0, 161.0, 197.0, 147.0, 140.0, 121.0, 165.0, 149.0, 149.0], "value": 150.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 198.0, 198.0, 195.0, 200.0, 196.0, 196.0, 194.0, 210.0, 197.0], "value": 197.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 77.0, 74.0, 145.0, 55.0, 116.0, 88.0, 65.0, 125.0, 59.0], "value": 86.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 81.0, 125.0, 61.0, 93.0, 149.0, 161.0, 116.0, 106.0, 162.0], "value": 113.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 106.0, 89.0, 86.0, 89.0, 85.0, 90.0, 87.0, 90.0, 85.0], "value": 89.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 97.0, 103.0, 104.0, 152.0, 149.0, 112.0, 93.0, 94.0, 94.0], "value": 109.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 91.0, 105.0, 127.0, 90.0, 85.0, 142.0, 149.0, 87.0, 91.0], "value": 105.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 63.0, 64.0, 64.0, 64.0, 65.0, 64.0, 78.0, 63.0, 59.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 64.0, 70.0, 66.0, 76.0, 70.0, 70.0, 61.0, 65.0, 67.0], "value": 67.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 80.0, 82.0, 89.0, 80.0, 81.0, 80.0, 78.0, 82.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 140.0, 142.0, 145.0, 123.0, 140.0, 142.0, 138.0, 172.0, 176.0], "value": 146.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 169.0, 165.0, 164.0, 164.0, 160.0, 163.0, 226.0, 217.0], "value": 176.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 95.0, 67.0, 65.0, 97.0, 95.0, 95.0, 76.0, 60.0], "value": 78.6, "unit": "score"}], "name": "kraken", "value": 1582.6999999999998, "alertThreshold": 2.0}]} 14:47:10 INFO - Return code: 0 14:47:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:47:10 ERROR - # TBPL SUCCESS # 14:47:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:47:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:47:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:47:10 INFO - 2016-06-29 14:47:10.907 screenresolution[2392:37657] starting screenresolution argv=screenresolution get 14:47:10 INFO - 2016-06-29 14:47:10.910 screenresolution[2392:37657] Display 0: 1600x1200x32@60 14:47:10 INFO - 2016-06-29 14:47:10.916 screenresolution[2393:37660] starting screenresolution argv=screenresolution list 14:47:10 INFO - Available Modes on Display 0 14:47:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:47:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:47:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:47:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:47:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:47:11 INFO - Intel Iris: 14:47:11 INFO - Chipset Model: Intel Iris 14:47:11 INFO - Type: GPU 14:47:11 INFO - Bus: Built-In 14:47:11 INFO - VRAM (Dynamic, Max): 1536 MB 14:47:11 INFO - Vendor: Intel (0x8086) 14:47:11 INFO - Device ID: 0x0a2e 14:47:11 INFO - Revision ID: 0x0009 14:47:11 INFO - Displays: 14:47:11 INFO - Display: 14:47:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:47:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:47:11 INFO - Display Serial Number: 1600x1200 60 14:47:11 INFO - Main Display: Yes 14:47:11 INFO - Mirror: Off 14:47:11 INFO - Online: Yes 14:47:11 INFO - Rotation: Supported 14:47:11 INFO - Return code: 0 14:47:11 INFO - Running post-action listener: _resource_record_post_action 14:47:11 INFO - Running post-run listener: _resource_record_post_run 14:47:12 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 1327104; Write bytes: 496507904; Read time: 9; Write time: 1563 14:47:12 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194640384; Write bytes: 197305344; Read time: 17586; Write time: 430 14:47:12 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 1302528; Write bytes: 298354688; Read time: 8; Write time: 1130 14:47:12 INFO - Running post-run listener: _upload_blobber_files 14:47:12 INFO - Blob upload gear active. 14:47:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:47:12 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 14:47:12 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'] 14:47:12 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 14:47:12 INFO - (blobuploader) - INFO - Open directory for files ... 14:47:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:47:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:47:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:47:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:47:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:47:13 INFO - (blobuploader) - INFO - Done attempting. 14:47:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:47:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:47:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:47:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:47:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:47:14 INFO - (blobuploader) - INFO - Done attempting. 14:47:14 INFO - (blobuploader) - INFO - Iteration through files over. 14:47:14 INFO - Return code: 0 14:47:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:47:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:47:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01e451bd6fe2208b43c2ae7ee8c2d0e4cae2460f14990a88b13f2041e26d546ea66d78e2dfdaa0d61de6490eb6981de716a62dd506e929ca75cbfd3b15cb6add", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6bf9bb39c677298cac648e143fce831e3dc542a6d1e6d1ddc4cf6158121f265fc0694beeb3d5fcc8aa20a4f553f82a8b7340324be6a6606a7ba8b142894cd97e"} 14:47:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:47:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:47:14 INFO - Contents: 14:47:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01e451bd6fe2208b43c2ae7ee8c2d0e4cae2460f14990a88b13f2041e26d546ea66d78e2dfdaa0d61de6490eb6981de716a62dd506e929ca75cbfd3b15cb6add", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6bf9bb39c677298cac648e143fce831e3dc542a6d1e6d1ddc4cf6158121f265fc0694beeb3d5fcc8aa20a4f553f82a8b7340324be6a6606a7ba8b142894cd97e"} 14:47:14 INFO - Running post-run listener: copy_logs_to_upload_dir 14:47:14 INFO - Copying logs to upload dir... 14:47:14 INFO - mkdir: /builds/slave/test/build/upload/logs 14:47:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.995275 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-06-29 14:47:14.395186) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 14:47:14.398467) ========= 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.7zJmtIB6qZ/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.7qC0T7clAt/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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/01e451bd6fe2208b43c2ae7ee8c2d0e4cae2460f14990a88b13f2041e26d546ea66d78e2dfdaa0d61de6490eb6981de716a62dd506e929ca75cbfd3b15cb6add", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6bf9bb39c677298cac648e143fce831e3dc542a6d1e6d1ddc4cf6158121f265fc0694beeb3d5fcc8aa20a4f553f82a8b7340324be6a6606a7ba8b142894cd97e"} build_url:https://queue.taskcluster.net/v1/task/EJvlMMVWTzy1ItfIuTzEyg/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011067 build_url: 'https://queue.taskcluster.net/v1/task/EJvlMMVWTzy1ItfIuTzEyg/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/01e451bd6fe2208b43c2ae7ee8c2d0e4cae2460f14990a88b13f2041e26d546ea66d78e2dfdaa0d61de6490eb6981de716a62dd506e929ca75cbfd3b15cb6add", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6bf9bb39c677298cac648e143fce831e3dc542a6d1e6d1ddc4cf6158121f265fc0694beeb3d5fcc8aa20a4f553f82a8b7340324be6a6606a7ba8b142894cd97e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 14:47:14.430231) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 14:47:14.430549) ========= 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.7zJmtIB6qZ/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.7qC0T7clAt/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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.005146 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 14:47:14.478845) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 14:47:14.479161) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 14:47:14.479509) ========= ========= Total master_lag: 0.18 =========