builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0389 starttime: 1464274336.72 results: success (0) buildid: 20160526064139 builduid: 1235cebdd67347c5b9996d150f3dbc64 revision: 5564b762402e5c577f720c88244baeb641738b39 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 07:52:16.717578) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 07:52:16.718005) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 07:52:16.718283) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 07:52:16.763056) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 07:52:16.763430) ========= 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.U5krsy8vpS/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.fRzJkK2zSf/Listeners TMPDIR=/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-26 07:52:16-- 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% 159M=0s 2016-05-26 07:52:16 (159 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117785 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 07:52:16.904714) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 07:52:16.905063) ========= 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.U5krsy8vpS/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.fRzJkK2zSf/Listeners TMPDIR=/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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.025173 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 07:52:16.957214) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-26 07:52:16.957555) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5564b762402e5c577f720c88244baeb641738b39 --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 5564b762402e5c577f720c88244baeb641738b39 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.U5krsy8vpS/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.fRzJkK2zSf/Listeners TMPDIR=/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-26 07:52:17,036 truncating revision to first 12 chars 2016-05-26 07:52:17,036 Setting DEBUG logging. 2016-05-26 07:52:17,036 attempt 1/10 2016-05-26 07:52:17,036 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5564b762402e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-26 07:52:18,078 unpacking tar archive at: mozilla-beta-5564b762402e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.323017 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-26 07:52:18.300207) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 07:52:18.300512) ========= script_repo_revision: 5564b762402e5c577f720c88244baeb641738b39 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 07:52:18.300909) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 07:52:18.301176) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 07:52:18.317215) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-05-26 07:52:18.317484) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.U5krsy8vpS/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.fRzJkK2zSf/Listeners TMPDIR=/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 07:52:18 INFO - MultiFileLogger online at 20160526 07:52:18 in /builds/slave/test 07:52:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 07:52:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:52:18 INFO - {'append_to_log': False, 07:52:18 INFO - 'base_work_dir': '/builds/slave/test', 07:52:18 INFO - 'blob_upload_branch': 'Mozilla-Beta', 07:52:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:52:18 INFO - 'branch': 'Mozilla-Beta', 07:52:18 INFO - 'buildbot_json_path': 'buildprops.json', 07:52:18 INFO - 'config_files': ('talos/mac_config.py',), 07:52:18 INFO - 'default_actions': ('clobber', 07:52:18 INFO - 'read-buildbot-config', 07:52:18 INFO - 'download-and-extract', 07:52:18 INFO - 'populate-webroot', 07:52:18 INFO - 'create-virtualenv', 07:52:18 INFO - 'install', 07:52:18 INFO - 'run-tests'), 07:52:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:52:18 INFO - 'download_minidump_stackwalk': True, 07:52:18 INFO - 'download_symbols': 'ondemand', 07:52:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:52:18 INFO - 'tooltool.py': '/tools/tooltool.py', 07:52:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:52:18 INFO - '/tools/misc-python/virtualenv.py')}, 07:52:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:52:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:52:18 INFO - 'installer_path': 'installer.exe', 07:52:18 INFO - 'log_level': 'info', 07:52:18 INFO - 'log_name': 'talos', 07:52:18 INFO - 'log_to_console': True, 07:52:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:52:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:52:18 INFO - 'opt_config_files': (), 07:52:18 INFO - 'pip_index': False, 07:52:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:52:18 INFO - 'cmd': ('bash', 07:52:18 INFO - '-c', 07:52:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:52:18 INFO - 'enabled': True, 07:52:18 INFO - 'halt_on_failure': False, 07:52:18 INFO - 'name': 'check_screen_resolution'},), 07:52:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:52:18 INFO - 'cmd': ('bash', 07:52:18 INFO - '-c', 07:52:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:52:18 INFO - 'enabled': True, 07:52:18 INFO - 'halt_on_failure': False, 07:52:18 INFO - 'name': 'check_screen_resolution'},), 07:52:18 INFO - 'run_cmd_checks_enabled': True, 07:52:18 INFO - 'sps_profile': False, 07:52:18 INFO - 'sps_profile_interval': 0, 07:52:18 INFO - 'suite': 'dromaeojs', 07:52:18 INFO - 'system_bits': '32', 07:52:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:52:18 INFO - 'title': 't-yosemite-r7-0389', 07:52:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:52:18 INFO - 'use_talos_json': True, 07:52:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:52:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:52:18 INFO - 'work_dir': 'build'} 07:52:18 INFO - ##### 07:52:18 INFO - ##### Running clobber step. 07:52:18 INFO - ##### 07:52:18 INFO - Running pre-action listener: _resource_record_pre_action 07:52:18 INFO - Running main action method: clobber 07:52:18 INFO - rmtree: /builds/slave/test/build 07:52:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:52:20 INFO - Running post-action listener: _resource_record_post_action 07:52:20 INFO - ##### 07:52:20 INFO - ##### Running read-buildbot-config step. 07:52:20 INFO - ##### 07:52:20 INFO - Running pre-action listener: _resource_record_pre_action 07:52:20 INFO - Running main action method: read_buildbot_config 07:52:20 INFO - Using buildbot properties: 07:52:20 INFO - { 07:52:20 INFO - "project": "", 07:52:20 INFO - "product": "firefox", 07:52:20 INFO - "script_repo_revision": "production", 07:52:20 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 07:52:20 INFO - "repository": "", 07:52:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 07:52:20 INFO - "buildid": "20160526064139", 07:52:20 INFO - "pgo_build": "False", 07:52:20 INFO - "basedir": "/builds/slave/test", 07:52:20 INFO - "buildnumber": 9, 07:52:20 INFO - "slavename": "t-yosemite-r7-0389", 07:52:20 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 07:52:20 INFO - "platform": "yosemite_r7", 07:52:20 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 07:52:20 INFO - "branch": "mozilla-beta", 07:52:20 INFO - "repo_path": "releases/mozilla-beta", 07:52:20 INFO - "revision": "5564b762402e5c577f720c88244baeb641738b39", 07:52:20 INFO - "stage_platform": "macosx64", 07:52:20 INFO - "builduid": "1235cebdd67347c5b9996d150f3dbc64", 07:52:20 INFO - "slavebuilddir": "test" 07:52:20 INFO - } 07:52:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 07:52:20 INFO - Running post-action listener: _resource_record_post_action 07:52:20 INFO - ##### 07:52:20 INFO - ##### Running download-and-extract step. 07:52:20 INFO - ##### 07:52:20 INFO - Running pre-action listener: _resource_record_pre_action 07:52:20 INFO - Running main action method: download_and_extract 07:52:20 INFO - mkdir: /builds/slave/test/build/tests 07:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:20 INFO - https://queue.taskcluster.net/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 07:52:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 07:52:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 07:52:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 07:52:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 07:52:24 INFO - Downloaded 1241 bytes. 07:52:24 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 07:52:24 INFO - Using the following test package requirements: 07:52:24 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 07:52:24 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 07:52:24 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 07:52:24 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 07:52:24 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 07:52:24 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 07:52:24 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 07:52:24 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 07:52:24 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 07:52:24 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 07:52:24 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 07:52:24 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 07:52:24 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 07:52:24 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 07:52:24 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 07:52:24 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 07:52:24 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 07:52:24 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 07:52:24 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 07:52:24 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')]} 07:52:24 INFO - https://queue.taskcluster.net/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:52:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 07:52:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 07:52:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 07:52:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 07:52:26 INFO - Downloaded 17816880 bytes. 07:52:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:52:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:52:29 INFO - Return code: 0 07:52:29 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 07:52:29 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')]} 07:52:29 INFO - https://queue.taskcluster.net/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:52:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 07:52:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 07:52:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 07:52:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 07:52:59 INFO - Downloaded 17816880 bytes. 07:52:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:52:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:53:03 INFO - Return code: 0 07:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:03 INFO - https://queue.taskcluster.net/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:53:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 07:53:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 07:53:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 07:53:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 07:53:04 INFO - Downloaded 10845194 bytes. 07:53:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:53:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 07:53:04 INFO - Return code: 0 07:53: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')]} 07:53:04 INFO - https://queue.taskcluster.net/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 07:53:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.dmg 07:53:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.dmg 07:53:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 07:53:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 07:53:07 INFO - Downloaded 88467462 bytes. 07:53:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.dmg 07:53:07 INFO - mkdir: /builds/slave/test/properties 07:53:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:53:07 INFO - Writing to file /builds/slave/test/properties/build_url 07:53:07 INFO - Contents: 07:53:07 INFO - build_url:https://queue.taskcluster.net/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.dmg 07:53:08 INFO - Running post-action listener: _resource_record_post_action 07:53:08 INFO - Running post-action listener: set_extra_try_arguments 07:53:08 INFO - ##### 07:53:08 INFO - ##### Running populate-webroot step. 07:53:08 INFO - ##### 07:53:08 INFO - Running pre-action listener: _resource_record_pre_action 07:53:08 INFO - Running main action method: populate_webroot 07:53:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:53:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:53:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:53:08 INFO - '--tppagecycles', 07:53:08 INFO - '7'], 07:53:08 INFO - 'tests': ['tsvgm']}}, 07:53:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:53:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:53:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:53:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 07:53:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:53:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:53:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:53:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:08 INFO - 'talos_options': ['--e10s'], 07:53:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:53:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:08 INFO - 'tests': ['damp', 'tps']}, 07:53:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:08 INFO - 'talos_options': ['--e10s'], 07:53:08 INFO - 'tests': ['damp', 'tps']}, 07:53:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:53:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:53:08 INFO - 'other': {'tests': ['a11yr', 07:53:08 INFO - 'ts_paint', 07:53:08 INFO - 'tpaint', 07:53:08 INFO - 'sessionrestore', 07:53:08 INFO - 'sessionrestore_no_auto_restore', 07:53:08 INFO - 'tabpaint']}, 07:53:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:53:08 INFO - 'tests': ['a11yr', 07:53:08 INFO - 'ts_paint', 07:53:08 INFO - 'tpaint', 07:53:08 INFO - 'sessionrestore', 07:53:08 INFO - 'sessionrestore_no_auto_restore', 07:53:08 INFO - 'tabpaint']}, 07:53:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:53:08 INFO - 'tests': ['a11yr', 07:53:08 INFO - 'ts_paint', 07:53:08 INFO - 'tpaint', 07:53:08 INFO - 'sessionrestore', 07:53:08 INFO - 'sessionrestore_no_auto_restore', 07:53:08 INFO - 'tabpaint']}, 07:53:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:53:08 INFO - 'tests': ['a11yr', 07:53:08 INFO - 'ts_paint', 07:53:08 INFO - 'tpaint', 07:53:08 INFO - 'sessionrestore', 07:53:08 INFO - 'sessionrestore_no_auto_restore', 07:53:08 INFO - 'tabpaint']}, 07:53:08 INFO - 'other_l64': {'tests': ['a11yr', 07:53:08 INFO - 'ts_paint', 07:53:08 INFO - 'tpaint', 07:53:08 INFO - 'sessionrestore', 07:53:08 INFO - 'sessionrestore_no_auto_restore', 07:53:08 INFO - 'tabpaint']}, 07:53:08 INFO - 'other_nol64': {'tests': ['a11yr', 07:53:08 INFO - 'ts_paint', 07:53:08 INFO - 'tpaint', 07:53:08 INFO - 'sessionrestore', 07:53:08 INFO - 'sessionrestore_no_auto_restore', 07:53:08 INFO - 'tabpaint']}, 07:53:08 INFO - 'svgr': {'tests': ['tsvgx', 07:53:08 INFO - 'tsvgr_opacity', 07:53:08 INFO - 'tart', 07:53:08 INFO - 'tscrollx', 07:53:08 INFO - 'cart']}, 07:53:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:53:08 INFO - 'tests': ['tsvgx', 07:53:08 INFO - 'tsvgr_opacity', 07:53:08 INFO - 'tart', 07:53:08 INFO - 'tscrollx', 07:53:08 INFO - 'cart']}, 07:53:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:08 INFO - 'tests': ['tp5o']}, 07:53:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:08 INFO - 'talos_options': ['--e10s'], 07:53:08 INFO - 'tests': ['tp5o']}, 07:53:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:08 INFO - 'talos_options': ['--xperf_path', 07:53:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:53:08 INFO - 'tests': ['tp5n']}, 07:53:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:08 INFO - 'talos_options': ['--e10s', 07:53:08 INFO - '--xperf_path', 07:53:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:53:08 INFO - 'tests': ['tp5n']}}, 07:53:08 INFO - 'talos.zip': {'path': '', 07:53:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:53:08 INFO - Running post-action listener: _resource_record_post_action 07:53:08 INFO - ##### 07:53:08 INFO - ##### Running create-virtualenv step. 07:53:08 INFO - ##### 07:53:08 INFO - Running pre-action listener: _resource_record_pre_action 07:53:08 INFO - Running main action method: create_virtualenv 07:53:08 INFO - Creating virtualenv /builds/slave/test/build/venv 07:53:08 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 07:53:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:53:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:53:08 INFO - Using real prefix '/tools/python27' 07:53:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:53:09 INFO - Installing distribute.............................................................................................................................................................................................done. 07:53:12 INFO - Installing pip.................done. 07:53:12 INFO - Return code: 0 07:53:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:53:12 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')]} 07:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:12 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')]} 07:53:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:12 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 0x10fe03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe0a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba60451300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fca7d30>, '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 0x10fb0bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc9eb20>, '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.U5krsy8vpS/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.fRzJkK2zSf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 07:53:12 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 07:53:12 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 07:53:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U5krsy8vpS/Render', 07:53:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:12 INFO - 'HOME': '/Users/cltbld', 07:53:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:12 INFO - 'LOGNAME': 'cltbld', 07:53:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:12 INFO - 'MOZ_NO_REMOTE': '1', 07:53:12 INFO - 'NO_EM_RESTART': '1', 07:53:12 INFO - 'PAGER': '/bin/cat', 07:53:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:12 INFO - 'PWD': '/builds/slave/test', 07:53:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:12 INFO - 'SHELL': '/bin/bash', 07:53:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fRzJkK2zSf/Listeners', 07:53:12 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 07:53:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:12 INFO - 'USER': 'cltbld', 07:53:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:12 INFO - 'XPC_FLAGS': '0x0', 07:53:12 INFO - 'XPC_SERVICE_NAME': '0', 07:53:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:12 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 07:53:12 INFO - Cleaning up... 07:53:12 INFO - Return code: 0 07:53:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:53:12 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')]} 07:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:12 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')]} 07:53:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:12 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 0x10fe03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe0a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba60451300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fca7d30>, '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 0x10fb0bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc9eb20>, '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.U5krsy8vpS/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.fRzJkK2zSf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 07:53:12 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 07:53:12 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 07:53:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U5krsy8vpS/Render', 07:53:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:12 INFO - 'HOME': '/Users/cltbld', 07:53:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:12 INFO - 'LOGNAME': 'cltbld', 07:53:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:12 INFO - 'MOZ_NO_REMOTE': '1', 07:53:12 INFO - 'NO_EM_RESTART': '1', 07:53:12 INFO - 'PAGER': '/bin/cat', 07:53:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:12 INFO - 'PWD': '/builds/slave/test', 07:53:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:12 INFO - 'SHELL': '/bin/bash', 07:53:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fRzJkK2zSf/Listeners', 07:53:12 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 07:53:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:12 INFO - 'USER': 'cltbld', 07:53:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:12 INFO - 'XPC_FLAGS': '0x0', 07:53:12 INFO - 'XPC_SERVICE_NAME': '0', 07:53:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:12 INFO - Downloading/unpacking psutil>=0.7.1 07:53: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 07:53: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 07:53: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 07:53: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 07:53: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 07:53: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 07:53:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:53:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:53:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:53:15 INFO - Installing collected packages: psutil 07:53:15 INFO - Running setup.py install for psutil 07:53:15 INFO - building 'psutil._psutil_osx' extension 07:53:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:53:16 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 07:53:16 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 07:53:16 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 07:53:16 INFO - building 'psutil._psutil_posix' extension 07:53:16 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 07:53:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:53:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:53:16 INFO - ^ 07:53:16 INFO - 1 warning generated. 07:53:16 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 07:53:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:53:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:53:16 INFO - Successfully installed psutil 07:53:16 INFO - Cleaning up... 07:53:16 INFO - Return code: 0 07:53:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:53:16 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')]} 07:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:16 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')]} 07:53:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:16 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 0x10fe03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe0a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba60451300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fca7d30>, '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 0x10fb0bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc9eb20>, '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.U5krsy8vpS/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.fRzJkK2zSf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 07:53:16 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 07:53:16 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 07:53:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U5krsy8vpS/Render', 07:53:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:16 INFO - 'HOME': '/Users/cltbld', 07:53:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:16 INFO - 'LOGNAME': 'cltbld', 07:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:16 INFO - 'MOZ_NO_REMOTE': '1', 07:53:16 INFO - 'NO_EM_RESTART': '1', 07:53:16 INFO - 'PAGER': '/bin/cat', 07:53:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:16 INFO - 'PWD': '/builds/slave/test', 07:53:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:16 INFO - 'SHELL': '/bin/bash', 07:53:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fRzJkK2zSf/Listeners', 07:53:16 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 07:53:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:16 INFO - 'USER': 'cltbld', 07:53:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:16 INFO - 'XPC_FLAGS': '0x0', 07:53:16 INFO - 'XPC_SERVICE_NAME': '0', 07:53:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:53:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:53:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:53:19 INFO - Installing collected packages: mozsystemmonitor 07:53:19 INFO - Running setup.py install for mozsystemmonitor 07:53:19 INFO - Successfully installed mozsystemmonitor 07:53:19 INFO - Cleaning up... 07:53:19 INFO - Return code: 0 07:53:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:53:19 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')]} 07:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:19 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')]} 07:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:19 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 0x10fe03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe0a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba60451300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fca7d30>, '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 0x10fb0bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc9eb20>, '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.U5krsy8vpS/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.fRzJkK2zSf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 07:53:19 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 07:53:19 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 07:53:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U5krsy8vpS/Render', 07:53:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:19 INFO - 'HOME': '/Users/cltbld', 07:53:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:19 INFO - 'LOGNAME': 'cltbld', 07:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:19 INFO - 'MOZ_NO_REMOTE': '1', 07:53:19 INFO - 'NO_EM_RESTART': '1', 07:53:19 INFO - 'PAGER': '/bin/cat', 07:53:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:19 INFO - 'PWD': '/builds/slave/test', 07:53:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:19 INFO - 'SHELL': '/bin/bash', 07:53:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fRzJkK2zSf/Listeners', 07:53:19 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 07:53:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:19 INFO - 'USER': 'cltbld', 07:53:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:19 INFO - 'XPC_FLAGS': '0x0', 07:53:19 INFO - 'XPC_SERVICE_NAME': '0', 07:53:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:20 INFO - Downloading/unpacking blobuploader==1.2.4 07:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:22 INFO - Downloading blobuploader-1.2.4.tar.gz 07:53:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:53:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:53:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:23 INFO - Downloading docopt-0.6.1.tar.gz 07:53:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:53:23 INFO - Installing collected packages: blobuploader, requests, docopt 07:53:23 INFO - Running setup.py install for blobuploader 07:53:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:53:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:53:24 INFO - Running setup.py install for requests 07:53:24 INFO - Running setup.py install for docopt 07:53:24 INFO - Successfully installed blobuploader requests docopt 07:53:24 INFO - Cleaning up... 07:53:24 INFO - Return code: 0 07:53:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:53:24 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')]} 07:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53: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')]} 07:53:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:25 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 0x10fe03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe0a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba60451300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fca7d30>, '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 0x10fb0bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc9eb20>, '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.U5krsy8vpS/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.fRzJkK2zSf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 07:53:25 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 07:53:25 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 07:53:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U5krsy8vpS/Render', 07:53:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:25 INFO - 'HOME': '/Users/cltbld', 07:53:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:25 INFO - 'LOGNAME': 'cltbld', 07:53:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:25 INFO - 'MOZ_NO_REMOTE': '1', 07:53:25 INFO - 'NO_EM_RESTART': '1', 07:53:25 INFO - 'PAGER': '/bin/cat', 07:53:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:25 INFO - 'PWD': '/builds/slave/test', 07:53:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:25 INFO - 'SHELL': '/bin/bash', 07:53:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fRzJkK2zSf/Listeners', 07:53:25 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 07:53:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:25 INFO - 'USER': 'cltbld', 07:53:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:25 INFO - 'XPC_FLAGS': '0x0', 07:53:25 INFO - 'XPC_SERVICE_NAME': '0', 07:53:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:53:25 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-URUkw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:53:25 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-xf4QdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:53:25 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-NRPt59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:53:25 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-IAf6Ef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:53:25 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-Wd5SeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:53:25 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-UaiBYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:53:26 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-G4gQPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:53:26 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-4MLTIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:53:26 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-zYZrRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:53:26 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-Xit69Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:53:26 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-Kgzzf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:53:26 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-ZjhuNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:53:26 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-iddpzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:53:26 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-HF1O4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:53:26 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-ttosHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:53:26 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-S7H9zg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:53:27 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-z1wBT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:53:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:53:27 INFO - Running setup.py install for manifestparser 07:53:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:53:27 INFO - Running setup.py install for mozcrash 07:53:27 INFO - Running setup.py install for mozdebug 07:53:27 INFO - Running setup.py install for mozdevice 07:53:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:53:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:53:27 INFO - Running setup.py install for mozfile 07:53:27 INFO - Running setup.py install for mozhttpd 07:53:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:53:28 INFO - Running setup.py install for mozinfo 07:53:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:53:28 INFO - Running setup.py install for mozInstall 07:53:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:53:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:53:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:53:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:53:28 INFO - Running setup.py install for mozleak 07:53:28 INFO - Running setup.py install for mozlog 07:53:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:53:28 INFO - Running setup.py install for moznetwork 07:53:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:53:28 INFO - Running setup.py install for mozprocess 07:53:28 INFO - Running setup.py install for mozprofile 07:53:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:53:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:53:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:53:29 INFO - Running setup.py install for mozrunner 07:53:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:53:29 INFO - Running setup.py install for mozscreenshot 07:53:29 INFO - Running setup.py install for moztest 07:53:29 INFO - Running setup.py install for mozversion 07:53:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:53:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:53:29 INFO - Cleaning up... 07:53:29 INFO - Return code: 0 07:53:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:53:29 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')]} 07:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:29 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')]} 07:53:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:29 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 0x10fe03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe0a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba60451300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fca7d30>, '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 0x10fb0bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc9eb20>, '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.U5krsy8vpS/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.fRzJkK2zSf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 07:53:29 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 07:53:29 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 07:53:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U5krsy8vpS/Render', 07:53:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:29 INFO - 'HOME': '/Users/cltbld', 07:53:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:29 INFO - 'LOGNAME': 'cltbld', 07:53:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:29 INFO - 'MOZ_NO_REMOTE': '1', 07:53:29 INFO - 'NO_EM_RESTART': '1', 07:53:29 INFO - 'PAGER': '/bin/cat', 07:53:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:29 INFO - 'PWD': '/builds/slave/test', 07:53:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:29 INFO - 'SHELL': '/bin/bash', 07:53:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fRzJkK2zSf/Listeners', 07:53:29 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 07:53:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:29 INFO - 'USER': 'cltbld', 07:53:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:29 INFO - 'XPC_FLAGS': '0x0', 07:53:29 INFO - 'XPC_SERVICE_NAME': '0', 07:53:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:53:30 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-Qufnu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:53:30 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)) 07:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:53:30 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-b3q40L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:53:30 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)) 07:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:53:30 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-lctgA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:53:30 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)) 07:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:53:30 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-KFGSDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:53:30 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)) 07:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:53:30 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-utVbPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:53:30 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)) 07:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:53:30 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-ECp95R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:53:30 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)) 07:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:53:30 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-4tfI9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:53:30 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)) 07:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:53:30 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-RB2ESH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:53:30 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)) 07:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:53:30 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-8I1Bwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:53:30 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)) 07:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:53:30 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-BQpqrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:53:31 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)) 07:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:53:31 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-OozYfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:53:31 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)) 07:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:53:31 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-I98evX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:53:31 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)) 07:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:53:31 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-qVbV29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:53:31 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)) 07:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:53:31 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-CWyisL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:53:31 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)) 07:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:53:31 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-Q7R4Vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:53:31 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)) 07:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:53:31 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-bWXDBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:53:31 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)) 07:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:53:31 INFO - Running setup.py (path:/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/pip-uCQj5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:53:31 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)) 07:53:31 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)) 07:53:31 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)) 07:53:31 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)) 07:53:31 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)) 07:53:31 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)) 07:53:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:53:31 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 07:53:31 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 07:53:31 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 07:53:31 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 07:53:31 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 07:53:31 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 07:53:34 INFO - Downloading blessings-1.6.tar.gz 07:53:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:53:34 INFO - Installing collected packages: blessings 07:53:34 INFO - Running setup.py install for blessings 07:53:34 INFO - Successfully installed blessings 07:53:34 INFO - Cleaning up... 07:53:34 INFO - Return code: 0 07:53:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:53:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:53:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:53:34 INFO - Reading from file tmpfile_stdout 07:53:34 INFO - Current package versions: 07:53:34 INFO - blessings == 1.6 07:53:34 INFO - blobuploader == 1.2.4 07:53:34 INFO - docopt == 0.6.1 07:53:34 INFO - manifestparser == 1.1 07:53:34 INFO - mozInstall == 1.12 07:53:34 INFO - mozcrash == 0.17 07:53:34 INFO - mozdebug == 0.1 07:53:34 INFO - mozdevice == 0.48 07:53:34 INFO - mozfile == 1.2 07:53:34 INFO - mozhttpd == 0.7 07:53:34 INFO - mozinfo == 0.9 07:53:34 INFO - mozleak == 0.1 07:53:34 INFO - mozlog == 3.1 07:53:34 INFO - moznetwork == 0.27 07:53:34 INFO - mozprocess == 0.22 07:53:34 INFO - mozprofile == 0.28 07:53:34 INFO - mozrunner == 6.11 07:53:34 INFO - mozscreenshot == 0.1 07:53:34 INFO - mozsystemmonitor == 0.0 07:53:34 INFO - moztest == 0.7 07:53:34 INFO - mozversion == 1.4 07:53:34 INFO - psutil == 3.1.1 07:53:34 INFO - requests == 1.2.3 07:53:34 INFO - wsgiref == 0.1.2 07:53:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:53:34 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')]} 07:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:34 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')]} 07:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:34 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 0x10fe03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe0a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba60451300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fca7d30>, '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 0x10fb0bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc9eb20>, '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.U5krsy8vpS/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.fRzJkK2zSf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 07:53:34 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 07:53:34 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 07:53:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U5krsy8vpS/Render', 07:53:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:34 INFO - 'HOME': '/Users/cltbld', 07:53:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:34 INFO - 'LOGNAME': 'cltbld', 07:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:34 INFO - 'MOZ_NO_REMOTE': '1', 07:53:34 INFO - 'NO_EM_RESTART': '1', 07:53:34 INFO - 'PAGER': '/bin/cat', 07:53:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:34 INFO - 'PWD': '/builds/slave/test', 07:53:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:34 INFO - 'SHELL': '/bin/bash', 07:53:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fRzJkK2zSf/Listeners', 07:53:34 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 07:53:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:34 INFO - 'USER': 'cltbld', 07:53:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:34 INFO - 'XPC_FLAGS': '0x0', 07:53:34 INFO - 'XPC_SERVICE_NAME': '0', 07:53:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:35 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)) 07:53:35 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)) 07:53:35 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)) 07:53:35 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)) 07:53:35 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)) 07:53:35 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)) 07:53:35 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)) 07:53:35 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)) 07:53:35 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)) 07:53:35 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)) 07:53:35 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)) 07:53:35 INFO - Cleaning up... 07:53:35 INFO - Return code: 0 07:53:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:53:35 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')]} 07:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:35 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')]} 07:53:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:35 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 0x10fe03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe0a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba60451300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fca7d30>, '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 0x10fb0bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc9eb20>, '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.U5krsy8vpS/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.fRzJkK2zSf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 07:53:35 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 07:53:35 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 07:53:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U5krsy8vpS/Render', 07:53:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:35 INFO - 'HOME': '/Users/cltbld', 07:53:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:35 INFO - 'LOGNAME': 'cltbld', 07:53:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:35 INFO - 'MOZ_NO_REMOTE': '1', 07:53:35 INFO - 'NO_EM_RESTART': '1', 07:53:35 INFO - 'PAGER': '/bin/cat', 07:53:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:35 INFO - 'PWD': '/builds/slave/test', 07:53:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:35 INFO - 'SHELL': '/bin/bash', 07:53:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fRzJkK2zSf/Listeners', 07:53:35 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 07:53:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:35 INFO - 'USER': 'cltbld', 07:53:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:35 INFO - 'XPC_FLAGS': '0x0', 07:53:35 INFO - 'XPC_SERVICE_NAME': '0', 07:53:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:35 INFO - Downloading/unpacking jsonschema 07:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:53:37 INFO - Downloading/unpacking functools32 (from jsonschema) 07:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:38 INFO - Downloading functools32-3.2.3-2.tar.gz 07:53:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:53:38 INFO - warning: no files found matching '*.txt' 07:53:38 INFO - no previously-included directories found matching 'build' 07:53:38 INFO - no previously-included directories found matching 'dist' 07:53:38 INFO - no previously-included directories found matching '.git*' 07:53:38 INFO - Installing collected packages: jsonschema, functools32 07:53:38 INFO - Running setup.py install for functools32 07:53:38 INFO - warning: no files found matching '*.txt' 07:53:38 INFO - no previously-included directories found matching 'build' 07:53:38 INFO - no previously-included directories found matching 'dist' 07:53:38 INFO - no previously-included directories found matching '.git*' 07:53:38 INFO - Successfully installed jsonschema functools32 07:53:38 INFO - Cleaning up... 07:53:38 INFO - Return code: 0 07:53:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:53:38 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')]} 07:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:38 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')]} 07:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:38 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 0x10fe03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe0a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba60451300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fca7d30>, '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 0x10fb0bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc9eb20>, '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.U5krsy8vpS/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.fRzJkK2zSf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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 07:53:38 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 07:53:38 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 07:53:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U5krsy8vpS/Render', 07:53:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:38 INFO - 'HOME': '/Users/cltbld', 07:53:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:38 INFO - 'LOGNAME': 'cltbld', 07:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:38 INFO - 'MOZ_NO_REMOTE': '1', 07:53:38 INFO - 'NO_EM_RESTART': '1', 07:53:38 INFO - 'PAGER': '/bin/cat', 07:53:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:38 INFO - 'PWD': '/builds/slave/test', 07:53:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:38 INFO - 'SHELL': '/bin/bash', 07:53:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fRzJkK2zSf/Listeners', 07:53:38 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 07:53:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:38 INFO - 'USER': 'cltbld', 07:53:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:38 INFO - 'XPC_FLAGS': '0x0', 07:53:38 INFO - 'XPC_SERVICE_NAME': '0', 07:53:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:38 INFO - Downloading/unpacking flake8 07:53:38 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 07:53:38 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 07:53:38 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 07:53:38 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 07:53:38 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 07:53:38 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 07:53:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:53:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:53:41 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 07:53:41 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 07:53:41 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 07:53:41 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 07:53:41 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 07:53:41 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 07:53:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:53:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:53:41 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 07:53:41 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 07:53:41 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 07:53:41 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 07:53:41 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 07:53:41 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 07:53:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:53:42 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 07:53:42 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 07:53:42 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 07:53:42 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 07:53:42 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 07:53:42 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 07:53:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:53:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:53:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:53:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:53:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:53:42 INFO - no previously-included directories found matching 'docs/_build' 07:53:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:53:42 INFO - Running setup.py install for pep8 07:53:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:53:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:53:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:53:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:53:42 INFO - no previously-included directories found matching 'docs/_build' 07:53:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:53:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:53:42 INFO - Cleaning up... 07:53:42 INFO - Return code: 0 07:53:42 INFO - Running post-action listener: _resource_record_post_action 07:53:42 INFO - Running post-action listener: _start_resource_monitoring 07:53:42 INFO - Starting resource monitoring. 07:53:42 INFO - ##### 07:53:42 INFO - ##### Running install step. 07:53:42 INFO - ##### 07:53:42 INFO - Running pre-action listener: _resource_record_pre_action 07:53:42 INFO - Running main action method: install 07:53:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:53:43 INFO - Reading from file tmpfile_stdout 07:53:43 INFO - Detecting whether we're running mozinstall >=1.0... 07:53:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:53:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:53:43 INFO - Reading from file tmpfile_stdout 07:53:43 INFO - Output received: 07:53:43 INFO - Usage: mozinstall [options] installer 07:53:43 INFO - Options: 07:53:43 INFO - -h, --help show this help message and exit 07:53:43 INFO - -d DEST, --destination=DEST 07:53:43 INFO - Directory to install application into. [default: 07:53:43 INFO - "/builds/slave/test"] 07:53:43 INFO - --app=APP Application being installed. [default: firefox] 07:53:43 INFO - mkdir: /builds/slave/test/build/application 07:53:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:53:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 07:54:05 INFO - Reading from file tmpfile_stdout 07:54:05 INFO - Output received: 07:54:05 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 07:54:05 INFO - Running post-action listener: _resource_record_post_action 07:54:05 INFO - ##### 07:54:05 INFO - ##### Running run-tests step. 07:54:05 INFO - ##### 07:54:05 INFO - Running pre-action listener: _resource_record_pre_action 07:54:05 INFO - Running main action method: run_tests 07:54:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:54:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:54:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:54:05 INFO - 2016-05-26 07:54:05.373 screenresolution[1646:7653] starting screenresolution argv=screenresolution get 07:54:05 INFO - 2016-05-26 07:54:05.376 screenresolution[1646:7653] Display 0: 1600x1200x32@60 07:54:05 INFO - 2016-05-26 07:54:05.382 screenresolution[1647:7655] starting screenresolution argv=screenresolution list 07:54:05 INFO - Available Modes on Display 0 07:54:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:54:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:54:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:54:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:54:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:54:05 INFO - Intel Iris: 07:54:05 INFO - Chipset Model: Intel Iris 07:54:05 INFO - Type: GPU 07:54:05 INFO - Bus: Built-In 07:54:05 INFO - VRAM (Dynamic, Max): 1536 MB 07:54:05 INFO - Vendor: Intel (0x8086) 07:54:05 INFO - Device ID: 0x0a2e 07:54:05 INFO - Revision ID: 0x0009 07:54:05 INFO - Displays: 07:54:05 INFO - Display: 07:54:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:54:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:54:05 INFO - Display Serial Number: 1600x1200 60 07:54:05 INFO - Main Display: Yes 07:54:05 INFO - Mirror: Off 07:54:05 INFO - Online: Yes 07:54:05 INFO - Rotation: Supported 07:54:05 INFO - Return code: 0 07:54:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:54:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:54:05 INFO - Python 2.7.3 07:54:05 INFO - Return code: 0 07:54:05 INFO - grabbing minidump binary from tooltool 07:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:54:05 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 0x10fca7d30>, '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 0x10fb0bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc9eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:54:05 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 07:54:05 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 07:54:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:54:05 INFO - Return code: 0 07:54:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:54:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:54:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:54:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:54:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:54:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:54:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:54:06 INFO - Return code: 0 07:54:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0389', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:54:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0389 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:54:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U5krsy8vpS/Render', 07:54:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:06 INFO - 'HOME': '/Users/cltbld', 07:54:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:06 INFO - 'LOGNAME': 'cltbld', 07:54:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:54:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:54:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:06 INFO - 'MOZ_NO_REMOTE': '1', 07:54:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:54:06 INFO - 'NO_EM_RESTART': '1', 07:54:06 INFO - 'PAGER': '/bin/cat', 07:54:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:06 INFO - 'PWD': '/builds/slave/test', 07:54:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:54:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:06 INFO - 'SHELL': '/bin/bash', 07:54:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fRzJkK2zSf/Listeners', 07:54:06 INFO - 'TMPDIR': '/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/', 07:54:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:06 INFO - 'USER': 'cltbld', 07:54:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:06 INFO - 'XPC_FLAGS': '0x0', 07:54:06 INFO - 'XPC_SERVICE_NAME': '0', 07:54:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0389', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:54:07 INFO - mozversion application_buildid: 20160526064139 07:54:07 INFO - mozversion application_changeset: 5564b762402e5c577f720c88244baeb641738b39 07:54:07 INFO - mozversion application_display_name: Firefox 07:54:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:54:07 INFO - mozversion application_name: Firefox 07:54:07 INFO - mozversion application_remotingname: firefox 07:54:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:54:07 INFO - mozversion application_vendor: Mozilla 07:54:07 INFO - mozversion application_version: 47.0 07:54:07 INFO - mozversion platform_buildid: 20160526064139 07:54:07 INFO - mozversion platform_changeset: 5564b762402e5c577f720c88244baeb641738b39 07:54:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:54:07 INFO - mozversion platform_version: 47.0 07:54:07 INFO - using testdate: 1464274447 07:54:07 INFO - actual date: 1464274447 07:54:07 INFO - starting webserver on 'localhost:49276' 07:54:07 INFO - SUITE-START | Running 2 tests 07:54:07 INFO - TEST-START | dromaeo_css 07:54:07 INFO - operating with platform_type : mac_ 07:54:07 INFO - Initialising browser for dromaeo_css test... 07:54:07 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/tmpUSrl0c/profile http://localhost:49276/getInfo.html) 07:54:09 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 07:54:09 INFO - PROCESS | 1665 | colorDepth:24 07:54:09 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 07:54:09 INFO - PROCESS | 1665 | __metrics 07:54:09 INFO - PROCESS | 1665 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:54:09 INFO - PROCESS | 1665 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:54:10 INFO - TEST-INFO | 1665: exit 0 07:54:10 INFO - Browser initialized. 07:54:10 INFO - Running cycle 1/1 for dromaeo_css test... 07:54:10 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/tmpUSrl0c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:54:22 INFO - PROCESS | 1668 | RSS: Main: 156876800 07:54:22 INFO - PROCESS | 1668 | 07:55:12 INFO - PROCESS | 1668 | 1464274512920 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] 07:57:22 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 07:57:24 INFO - PROCESS | 1668 | RSS: Main: 313004032 07:57:24 INFO - PROCESS | 1668 | 08:00:26 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 08:00:27 INFO - PROCESS | 1668 | RSS: Main: 294596608 08:00:27 INFO - PROCESS | 1668 | 08:03:29 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 08:03:30 INFO - PROCESS | 1668 | RSS: Main: 299298816 08:03:30 INFO - PROCESS | 1668 | 08:06:32 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 08:06:32 INFO - PROCESS | 1668 | RSS: Main: 258109440 08:06:32 INFO - PROCESS | 1668 | 08:09:35 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 08:09:36 INFO - PROCESS | 1668 | RSS: Main: 259010560 08:09:36 INFO - PROCESS | 1668 | 08:12:38 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 08:12:38 INFO - PROCESS | 1668 | RSS: Main: 305467392 08:12:38 INFO - PROCESS | 1668 | 08:12:38 INFO - PROCESS | 1668 | __start_tp_report 08:12:38 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 08:12:38 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 08:12:38 INFO - PROCESS | 1668 | |i|pagename|runs| 08:12:38 INFO - PROCESS | 1668 | |0;dojo.html;3509.15780212749;3517.40204165292;3549.272399158173;3591.479235510851;3606.441001644745;5700.686462244575;5732.054211055181;5749.166370876221;5753.971230143843;5781.884362312751;5710.914336284959;5763.5389168866495;5773.653580785156;5775.480206781389;5806.912896306549;5164.483551644824;5240.082985477527;5265.262863199146;5291.735413229323;5383.542398896079;5305.204219367087;5323.0152421801895;5330.520253177213;5330.866728331784;5331.306930099082;4225.492940847103;5263;5267.078261304257;5292.020976119411;5306.602004849632;5317.096093664087;5348.465153484659;5354.973225133888;5362.785488580452;5376.731163441851;5100.7959681613065;5264.9736751315995;5274.789008439658;5277.8416647500635;5280.07598670235;5646.887062258732;5675.716214189315;5690.146478028288;5701.287339082614;5728.68492232927;6163.691815409212;6305.905411418832;6324.7470101195895;6336.176297081396;6356.491480681534;6240.188775459206;6250.749970001195;6263.279722831887;6289.8742025159245;6334.588251763621;5919.704014799243;5972.044472884361;5974.074018527135;5975.731092100866;6012.488938440194;6237.937620623736;6344.206974128234;6349;6363.077353783768;6492.09110724499;6112.358202388774;6232.501399887998;6255.499560035186;6263.874722505524;6323.30443651198;6293.716782744696;6325.9051114233325;6330.240371155399;6334.778282760173;6345.0482427636225;6122.947104152868;6215.782447614311;6253.6560489172625;6316.178896743394;6325.620462772248;6215.160953271251;6224.221972253468;6232.657203853741;6265.154204182377;6329.620222786648;4981.32752078472;4987.875303117378;4988.90022199554;4993.026359859865;5035.194368901031;4486.641068714495;4497.707649002804;4515.706479078849;4543.432070991126;4548.408706868086;5791.739371728198;5825.912611310834;5876.853078673067;5899.056151015817;5969.462748352669;6318.210223722035;6325.430711235919;6329.651869147241;6352.047192921006;6359.300476947532;5913.526917846562;5952.114121203964;5953.077273022688;5963.880722385528;5964.671943043088;5337.86655333612;5344.278522399426;5390.703511306838;5436.728163591804;5492.5331346835965;6343.619382837044;6358.809235722843;6363.61818290904;6368.554201205871;6372.968135159294;6260.280067792262;6306.180196574416;6311.400416960381;6331.240251169889;6340.207474065742;6270.404311590391;6331.145295385249;6339.2392912850755;6376.74493020274;6378.425941665272;6238.594491358229;6255;6298.464630506458;6301.212348456443;6313.463355614824;6211.068339749074;6313.842153946004;6322.178116844781;6327.557071004985;6342.175517182736;6063.909041364472;6073.635581865102;6129.35641757609;6130.000698177663;6133.478654314434;6157.907631385622;6185.659743738331;6190.81427557174;6213.099100630293;6216.098665693539;5832.096025116114;5846.35690074083;6086.452219300284;6105.786297479567;6107.541934354852;6055.666938318434;6116.674139391257;6131.866048757478;6135.085739396129;6136.839527643178;6096.969515152396;6097.390260973867;6131.110988906673;6137.079438084323;6151.231096112986 08:12:38 INFO - PROCESS | 1668 | |1;ext.html;472.63607022592606;550.7383992603517;575.59708204257;603.5895590998123;675.864547560099;32534;40660;40711.38932916008;40834.38748418776;40887.38668919969;43678.781606092;44471.555284447146;44493.55506444935;44554.10891782162;44637;9723.708288751348;9949.204063674888;9955.352902061379;9962.601495940155;9971.650992215275;9744.707658770212;9873.703788886309;9892.40645561265;9978;9981.90018099817;9932.35439696421;9972.451515166664;9976.05227503386;9983.750406239866;9986.600535978589;9856.753581160458;9930.006999300085;9943.651972181011;9962.701118966406;9984;9791;9909.65316213929;9929.404235745878;9940.254480913887;9954.104130628279;40936.79531602353;42788.78605606983;43327.78336108331;43490;43512;3247.382997230519;3444.810535420551;3475.5134281200653;3724.478572999782;3930.410438434229;29207.707922920923;29934.700652993626;30058.398832023457;30096.548551771742;30723;2799.6360473138566;2829.1795379339965;2876.769858411343;2896.4496745618476;2943.705629437039;391046;391413;392073.0792692065;392657;392681;65987.67006164939;66033.6698316515;66421.6715665684;66472.33527664661;66726.33273667298;75773.62113189399;76850.2314976843;76858.6157069211;77150;77338.61330693311;15776.447824326093;18764.343247986257;18941.621167576846;18944.052797360077;18966.431007069536;14198.432062717582;14318;14327.856721432652;14330.49843255481;14351;22092.00585973635;22390.44023899383;22456.214032508782;22481.775182248297;22899.771002289763;8877.378583499092;9282.90717092834;9505.667301644547;9516.571754271074;9545.665901693408;888.3692578269502;1008.4655132779639;1059.9682009539727;1067.3595842494442;1161.0537412009185;29489.705102949127;29571;30154.24614384658;30695.23261918425;30897;1127.7800828838463;1161.6108603617884;1201.873803250646;1212.2908098762323;1263.9115261931577;14682.412703491955;14743;14864.851351486563;14865.331060102322;14930.178840163895;642882;659343;659877;663214;668035.319646807;60711.69644151751;61461.69269153626;61482.69258653678;61483.69258153681;61516;1414.5049232768654;1512.5916002679214;1529.831718510963;1550.317860141534;1551.3949559671737;27992.44015119727;29635.259118522208;29657.5551366734;30146.69853301439;31297.687023129478;49727;50274.24588631246;50290.748546258495;50442.24336635027;50479.24281135859;421717;422504;427939;428960;429168;34304.65695343114;45461;45763.77118114388;47873.281900772214;47891.04217915692;45311.320330194416;45598.54401455943;46129.30806037845;47045.29432058454;47169.76415117903;36381.45427818638;36692.63307366892;37698.2460350786;39422.817315480585;39525.80237098796;35012.649873501956;38819.41770873496;38963.08090357272;39163.804180978914;39780.403293951196;38083;38864.417033745085;38917.80541097277;39080.804595976835;39595.80202098971;33735.3252934935;34310;34338.82830585831;34504.65495345015;34589.48115778215;21836;25195;25974.961001559725;25980.740192598587;25994 08:12:38 INFO - PROCESS | 1668 | |2;jquery.html;380.29834954508937;384.22195055013594;384.58080692045667;388.75702685821364;390.50991006287103;20233.39299821006;21176.89411552942;21186.364409067715;21862.344129676094;21876.45308867279;21319.040643171054;21347.825869577206;21410.822404767732;21712.457188570294;21930.780692193075;5792.7972520961775;5857.4435428634215;6064.514838812906;6066.998945174041;6121.173641558399;4125.195586860564;4316.330968699841;5855.707214639272;6088.4215999479975;6093.786717464867;6040.395960403968;6073.574849760496;6080.14877917092;6086.695665216744;6087;5885.47030767233;5942.316633587128;6034.909476357858;6038.69806509675;6040.275166979946;5498.890022199574;5679.7160141993145;5753.194552762617;5758.136279558058;5776.566757493205;13977.3710183042;14353.856461435356;14400.927995359956;14414.855851441456;14437.494687685881;2181.9345419637434;2272.874991875446;2314.4329639238326;2418.3954011497126;2667.186508115024;10041.447720375376;10151.137153341975;10535.367877927349;10546.630867919586;10660.573577056908;1526.9389224431009;1705.4031089118832;1752.824717528237;1827.5339788354017;1833.6516061948187;108978;113797.4310128444;115882.42058789651;116335.83664163334;117224.41387793091;11563.07495400366;11625.069994400428;11670.299782013106;11702.88297117035;11807.173497855068;14392.992490525772;14418.062825916282;14457.710845783025;14474.927625362016;14491.565253042425;8714.825703485894;9027.052159523155;9048.321375896703;9105.271578273854;9131.589078491485;9369.859452108223;9386.67146649864;9391.953040234755;9476.715698529055;9481.4785186814;4513.480949690762;4595.425571803525;4596.49438561758;4635.443746750411;4644.419447569054;1582.272154808801;1770.6812773700858;1836.939232414689;1901.8003109673562;1903.9428817135508;938.7136923238478;971.708487453761;1000.6491236830221;1028.6399760083912;1121.170333952869;19249.903750481437;20237.190512379635;20310.172084512466;20353.185872564933;20577.794222057586;770.849684311565;990.3513198854762;1008.8184126857236;1024.359775140537;1029.063552167524;10918.836217456745;11278.154138439486;11389.886101139049;11512.76974460506;12285.815712764315;661028;666881;670549;674210;675533;117017;125020;126717.92287620193;126762;129906.70093298946;1098.1873413673984;1102.0577406317643;1104.6520346090956;1127.537709539085;1129.9661010169543;18703.438896833115;19199;19413.611727765085;19415.611687765882;19671.21315147378;50849.7287567799;52279.73860130675;53294;55345.44654553403;55933;76239.61880190785;79086.60456697679;79425;79445.60277198577;80069.19930800618;7010.298970102949;7058.294170582901;8062.39532035088;8272.420930535045;8444.831103378021;10243.487825608541;12433.564825231073;13203;13476.460941562227;13525.458981641017;10602.310849794738;10694.251402401756;11527.135464840003;11667.066634669376;11741.471633776671;11429.828552571884;11457.713557161138;11524.711882203012;11528.769424611628;11637.825432618349;11678.182527223013;11703.648890533297;11859.229150105215;12046.75906481848;12049.216800907912;8220.588970551567;8223.424360294961;8415.873761893454;8518.70184543538;8636.524991125549;11362.829557556477;11762.647120586396;11822.290662560274;11983.520659173535;12012.519499219934 08:12:38 INFO - PROCESS | 1668 | |3;mootools.html;1492.440334874422;1609.1230279497672;1610.3236640610942;1934.8355389791875;2072.2332736887356;8306.66773329067;8513.021002584705;8517.36119791015;8522.147785221474;8524.14758524148;8811.030786613468;9033.728988130366;9036.50299233542;9038.051004644516;9054.683086091987;2131.7228760261223;2509.3224829296123;2576.265764257187;2576.9355766105905;2578.6905571331467;2186.212963333199;2556.910508132216;2630.3950091478973;2634.5784674452093;2635.9472810543875;2534.8605826679527;2547.757962993522;2594.688637363519;2599.2462185966046;2600.660659760225;2211.9115235390564;2552.719200887901;2553.4510080332816;2576.2528866628654;2580.1098620975827;2604.817662763607;2615.6076588511687;2642.1016854269446;2643.2730998975244;2655.2034389683017;9131.497767622777;9175.77060573491;9176.632934682604;9201.401908875969;9218.723438296862;5525.834224973257;5689.829305120812;5738.42615738427;5748.626339287975;5759.1937128802;3633.6003039665616;3771.226898485831;3772.9622703772884;3778.301014312361;3842.385218365076;909.8316811389914;1098.5825386353215;1103.0128035408345;1105.7891608688474;1114.8049091409052;12246.693832654255;12477.563285285063;12478.563250286197;12500.874991250063;12558.937205313914;5004.524570165829;5059.772310246048;5156.329677141947;5162.53537181648;5162.535371816554;10754.946225268823;10775.461226938778;10781.62264320745;10782.946085269681;10791.730206744895;5733.885322293614;5796.82609521715;5809.390014048464;5813.476787089182;5813.6221145625395;4634.443866736014;4642.79107440166;4731.243001119804;4734.905301893943;5228.712420816892;4073.5926407359025;4092.283850326181;4146.398772178018;4161.396597493346;4178.770167640748;1215.6413857911937;1298.8245637697898;1366.5217173989024;1369.7534443800012;1377.5316392426623;1401.8878489720798;1434.2756907761723;1442.65376309687;1452.5932738833144;1457.890658200639;8360.45657032291;8432;8449;8534.78663033429;8553.101924297984;533.6477924569765;539.8650337415646;546.4644648244742;551.7020808763303;553.9307586551681;6352.587081839665;6399.328070552618;6402.807915762534;6435.935640643534;6435.938070218455;10906.672799816019;11290;11293.265937714023;11306.943465282786;11311.94344028291;10255.58977640901;10758.892411075789;10947.671569852917;10990.285631433931;11110.61112861046;8440.788980275542;8465.957670211732;8569.400141990125;8573.571321434029;8593.742187734379;8286.544240066854;8287.875681864656;8334.749957501284;8417.242448179693;8451;9390.154886060287;9792.069753373418;9852.605895764089;9866.950665246628;9910.405375677483;9753.707388778348;9874.259430542594;10081.647142349982;10091;10148.949255253676;7052.788416347517;7479.626018699152;7503.062117235346;7631.580263085583;7667.808304792425;8524.616392262487;8538.530380828866;8563.058063612873;8566.871496927426;8587.87118193215;7453.105627324756;7524.5861477619255;7545.962270188614;7639.350655194371;7715.189905060112;7452.515586486861;7454.142773580891;7470.140933792466;7532.983047288546;7577;7894.84210315779;7967.203279672218;7968.163342848918;8025.2777250047775;8066.274035336613;7222.169450513048;7270.927290727025;7275;7303.488755787044;7317.451191160578;7400.333969942731;7423.220561840929;7468.589227592317;7473.327400533978;7476.738314158978 08:12:38 INFO - PROCESS | 1668 | |4;prototype.html;333.5530389278367;339.80461234790005;344.2907610322734;346.8924633363657;349.8985294264663;6763.05317255584;6776.322367763221;6811.012403201539;6839.62382068986;6857.31426857314;5830.067189249721;6363.268224154223;6728.327167283269;6732.831679208022;6733.225679046911;4754.90490190196;4833.613310935134;4874.195757699975;4982.377202849644;5058.949410505885;4935.555799978001;4986.10250154972;4987.1521841286885;4990.625703072266;5005.074061298653;4946.530079642428;4949.579285760715;4958.925616115761;4959.256111583255;4966.652334336598;4769.785359658824;4858.441279252896;4938.2099114000475;4963.702177869303;4965.180745177042;4285.314349704064;4288.721233119837;4289.571042895685;4297.097609502009;4306.074194048263;6468.611883287018;6470.09418681385;6486.967565162191;6490.05894145351;6507.4794016479045;5859.824205273806;5864.061750120003;5871.001929671966;5873.559483038746;5874.882502349929;6832.760853370109;7101.89347159793;7113.110861142357;7114.928850711479;7122.92877071233;4614.492405835355;4618.0763847230355;4622.514635963209;4634.3048542718525;4647.163510568096;7393.926060739377;7495.962520187419;7505.099388073411;7517.887231691474;7525.962370188169;4708.764561771966;4714.976425117852;4725.881852953635;4726.763661816895;4738.47876733559;4769.451513076041;4774.546418090275;4778.95221047792;4780.665353425296;4787.281907713871;5451.264079349237;5680.147977803363;5686.800961966312;5701.686407247641;5715.742791574389;7127.7148914042855;7134.429245660334;7143.285671432815;7162.92837071633;7179.676914538753;1382.3917476310592;1620.3194658243567;1661.2607389711704;1661.651053278825;1664.2095004872588;995.318207028188;1011.1455819832377;1036.2073612650158;1049;1110.4447776111945;6714.832129196711;6750.966245168743;6767.796966091025;6776.898346524806;6778.118844550177;5935.376785437553;7355.190928997913;7359.153697324876;7378.852422951618;7390.22402647725;6728.831779205461;6760.222574403908;6773.593584384953;6774.051632771416;6774.525783195228;3751.3060083884025;3857.1128640412862;3898.6101389861356;3902.941455878164;3910.159315747128;7646.617669116522;7667.271609197229;7674.270944260286;7682.693942029869;7699.730509432143;7503.5873026982945;7528.774136775905;7542.358899493604;7557.319841214207;7577.810554736176;6172.722227499773;7599.886001709979;7635.389168866477;7638.159802421618;7644.50310729823;7068.929310706827;7317.634118293958;7327.780166595011;7335.1564570075125;7340.412766978522;7168.103987001625;7179.425645948416;7198.136223653195;7198.388137008413;7251.782446526613;6124.816255512342;7609.048868891388;7629.2370762923265;7629.504082234637;7637.045369328834;4918.631102667386;4940.505949405031;4943.678660887031;4949.30709700635;4954.5540901319055;7044.295570442915;7287.672054757442;7299.598522081336;7318.377937875341;7330;7014.5440546364325;7055.576665400093;7056.188538318159;7060.6116663584;7105.396041336544;7041.894371584533;7042.190148133031;7062.8234294141;7062.823429414306;7063.1524217094275;5602.943970560243;6907.585544867324;6910.93089069123;6916.930830691628;6918.93081069203;6724.7646332378135;6994.370506654425;7040.155181378267;7040.788776336718;7071.964640176766;6753.358430949052;6907.13660792401;6915.308469153246;6979.336962988508;7062.646867656494 08:12:38 INFO - PROCESS | 1668 | |5;yui.html;712.3873468816817;752.8833030880215;770.788033290845;772.8338407242442;800.2397722163946;14633.341499632515;14870.702585948275;14951.999999999987;14979.850201497982;14980.801535877132;14194.077384969996;14317.713645727079;14373.49692760751;14386.856131438708;14406.783898241509;812.7642983534782;833.9916600833975;966.9081437263449;967.796762679838;971.3540495570472;955.8231727130468;956.8373376525973;964.8600952861831;965.1651321606795;985.5515740338129;868.2186032570673;1020.2603112743276;1021.3973755484262;1025.4821315235795;1040.994795026024;1022.693192042388;1039.9584016639362;1041.6146025970363;1043.9582416703322;1045.5556388534842;769.4114002787871;775.53467919248;778.4550814429922;778.8247644280049;779.6530543907963;15202.239888005666;15259.847401525954;15264.16047117408;15308.081515109128;15309.157996310198;11956.641300760992;12746.235225886476;12864.807027894589;12878.613641590768;13088.738225235536;10143.036411540892;10195.592176312939;10263.07632313088;10562.683119506428;10639.202059845542;3478.843452044639;3495.10874726943;3520.0319912024142;3563.4120370139153;3737.635762946532;83216;83982.3203535932;84048.57975710144;84203;84235.57882210611;9966.750831229132;10008.949955250177;10011.949940250252;10044.648437304659;10096.14182794456;22343.88280585964;22446.887765561067;22453.663195052086;22557.887210563844;22589.983450744756;7762.961185194038;7801.141874393812;7840.09838868526;7976.162502937224;7978.800529986796;4244.236037513216;4255.085156691264;4331.45856767904;4549.613282870927;4594.908101837945;3595.065283026432;3692.8707495237536;3703.9629603704157;3734.2531493700826;3749.7000239980734;666.4435196610788;668.0580381661833;670.483727529809;672.9831754206086;686.1663079358603;516.3107251818789;539.9433059528772;553.1868153813887;593.2465768474013;596.2219303808484;7791.883121753178;8120.025596928288;8171.264586187272;8232.34141268697;8279.512864868042;500.2446306077776;580.6835274775258;591.1753104419311;605.6941244671413;608.0969759906535;3810.0855794609647;3817.541894972621;3874.670652994471;3875.806209689504;4060.796960151981;92198.53900730453;93698.06301936893;94737.0526294742;96488;96624.03375966291;80748.59625701833;81599;83535.582322088;83736.58131709424;84155.5792221035;73523.63238183882;74091;74163.62918185374;74356.25643743601;76312.23687763051;7487.625618719151;7561.621918904143;7652.502587331805;7956.681732730857;8212.794680132805;40558;51133.7443312781;51650.45048648547;51755.22367164571;51874.740626296625;56792.71603641955;67399;69377.65311173412;70811;71264.21839454056;10490.265681402228;11250.21248512629;11272.380019099028;11282.153838461983;11707.414629268333;11961.880381196077;12133.272003679807;12162.148649594797;12770;13500.25748583798;11659.358735269641;11906.285622862655;11915.702107447383;12120.212186207867;12230;11601.361925094201;11645.59240426581;11923;12005.159638825198;12067.275963442222;11458.713532161762;11578.76842463163;11635.53457861676;11689.123315751523;12125.029997600348;8097.2307630774985;9392.624295028123;9534.809303813747;9758.46328451942;9764.267679924176;9486.525673716425;9725.221982241545;9747.561359738971;9831.311808173645;9833.950830246089 08:12:38 INFO - PROCESS | 1668 | __end_tp_report 08:12:38 INFO - PROCESS | 1668 | __start_cc_report 08:12:38 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,1517 08:12:38 INFO - PROCESS | 1668 | __end_cc_report 08:12:38 INFO - PROCESS | 1668 | __startTimestamp1464275558955__endTimestamp 08:12:38 INFO - PROCESS | 1668 | 08:12:38 INFO - PROCESS | 1668 | ------- Summary: start ------- 08:12:38 INFO - PROCESS | 1668 | Number of tests: 6 08:12:38 INFO - PROCESS | 1668 | 08:12:38 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5823.52 Median:6097.39 stddev:632.85 (10.4%) stddev-sans-first:608.19 08:12:38 INFO - PROCESS | 1668 | Values: 3509.2 3517.4 3549.3 3591.5 3606.4 5700.7 5732.1 5749.2 5754.0 5781.9 5710.9 5763.5 5773.7 5775.5 5806.9 5164.5 5240.1 5265.3 5291.7 5383.5 5305.2 5323.0 5330.5 5330.9 5331.3 4225.5 5263.0 5267.1 5292.0 5306.6 5317.1 5348.5 5355.0 5362.8 5376.7 5100.8 5265.0 5274.8 5277.8 5280.1 5646.9 5675.7 5690.1 5701.3 5728.7 6163.7 6305.9 6324.7 6336.2 6356.5 6240.2 6250.7 6263.3 6289.9 6334.6 5919.7 5972.0 5974.1 5975.7 6012.5 6237.9 6344.2 6349.0 6363.1 6492.1 6112.4 6232.5 6255.5 6263.9 6323.3 6293.7 6325.9 6330.2 6334.8 6345.0 6122.9 6215.8 6253.7 6316.2 6325.6 6215.2 6224.2 6232.7 6265.2 6329.6 4981.3 4987.9 4988.9 4993.0 5035.2 4486.6 4497.7 4515.7 4543.4 4548.4 5791.7 5825.9 5876.9 5899.1 5969.5 6318.2 6325.4 6329.7 6352.0 6359.3 5913.5 5952.1 5953.1 5963.9 5964.7 5337.9 5344.3 5390.7 5436.7 5492.5 6343.6 6358.8 6363.6 6368.6 6373.0 6260.3 6306.2 6311.4 6331.2 6340.2 6270.4 6331.1 6339.2 6376.7 6378.4 6238.6 6255.0 6298.5 6301.2 6313.5 6211.1 6313.8 6322.2 6327.6 6342.2 6063.9 6073.6 6129.4 6130.0 6133.5 6157.9 6185.7 6190.8 6213.1 6216.1 5832.1 5846.4 6086.5 6105.8 6107.5 6055.7 6116.7 6131.9 6135.1 6136.8 6097.0 6097.4 6131.1 6137.1 6151.2 08:12:38 INFO - PROCESS | 1668 | 08:12:38 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:65338.73 Median:40220.20 stddev:134979.82 (335.6%) stddev-sans-first:135270.61 08:12:38 INFO - PROCESS | 1668 | Values: 472.6 550.7 575.6 603.6 675.9 32534.0 40660.0 40711.4 40834.4 40887.4 43678.8 44471.6 44493.6 44554.1 44637.0 9723.7 9949.2 9955.4 9962.6 9971.7 9744.7 9873.7 9892.4 9978.0 9981.9 9932.4 9972.5 9976.1 9983.8 9986.6 9856.8 9930.0 9943.7 9962.7 9984.0 9791.0 9909.7 9929.4 9940.3 9954.1 40936.8 42788.8 43327.8 43490.0 43512.0 3247.4 3444.8 3475.5 3724.5 3930.4 29207.7 29934.7 30058.4 30096.5 30723.0 2799.6 2829.2 2876.8 2896.4 2943.7 391046.0 391413.0 392073.1 392657.0 392681.0 65987.7 66033.7 66421.7 66472.3 66726.3 75773.6 76850.2 76858.6 77150.0 77338.6 15776.4 18764.3 18941.6 18944.1 18966.4 14198.4 14318.0 14327.9 14330.5 14351.0 22092.0 22390.4 22456.2 22481.8 22899.8 8877.4 9282.9 9505.7 9516.6 9545.7 888.4 1008.5 1060.0 1067.4 1161.1 29489.7 29571.0 30154.2 30695.2 30897.0 1127.8 1161.6 1201.9 1212.3 1263.9 14682.4 14743.0 14864.9 14865.3 14930.2 642882.0 659343.0 659877.0 663214.0 668035.3 60711.7 61461.7 61482.7 61483.7 61516.0 1414.5 1512.6 1529.8 1550.3 1551.4 27992.4 29635.3 29657.6 30146.7 31297.7 49727.0 50274.2 50290.7 50442.2 50479.2 421717.0 422504.0 427939.0 428960.0 429168.0 34304.7 45461.0 45763.8 47873.3 47891.0 45311.3 45598.5 46129.3 47045.3 47169.8 36381.5 36692.6 37698.2 39422.8 39525.8 35012.6 38819.4 38963.1 39163.8 39780.4 38083.0 38864.4 38917.8 39080.8 39595.8 33735.3 34310.0 34338.8 34504.7 34589.5 21836.0 25195.0 25975.0 25980.7 25994.0 08:12:38 INFO - PROCESS | 1668 | 08:12:38 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:36741.63 Median:20465.49 stddev:111038.69 (542.6%) stddev-sans-first:111316.62 08:12:38 INFO - PROCESS | 1668 | Values: 380.3 384.2 384.6 388.8 390.5 20233.4 21176.9 21186.4 21862.3 21876.5 21319.0 21347.8 21410.8 21712.5 21930.8 5792.8 5857.4 6064.5 6067.0 6121.2 4125.2 4316.3 5855.7 6088.4 6093.8 6040.4 6073.6 6080.1 6086.7 6087.0 5885.5 5942.3 6034.9 6038.7 6040.3 5498.9 5679.7 5753.2 5758.1 5776.6 13977.4 14353.9 14400.9 14414.9 14437.5 2181.9 2272.9 2314.4 2418.4 2667.2 10041.4 10151.1 10535.4 10546.6 10660.6 1526.9 1705.4 1752.8 1827.5 1833.7 108978.0 113797.4 115882.4 116335.8 117224.4 11563.1 11625.1 11670.3 11702.9 11807.2 14393.0 14418.1 14457.7 14474.9 14491.6 8714.8 9027.1 9048.3 9105.3 9131.6 9369.9 9386.7 9392.0 9476.7 9481.5 4513.5 4595.4 4596.5 4635.4 4644.4 1582.3 1770.7 1836.9 1901.8 1903.9 938.7 971.7 1000.6 1028.6 1121.2 19249.9 20237.2 20310.2 20353.2 20577.8 770.8 990.4 1008.8 1024.4 1029.1 10918.8 11278.2 11389.9 11512.8 12285.8 661028.0 666881.0 670549.0 674210.0 675533.0 117017.0 125020.0 126717.9 126762.0 129906.7 1098.2 1102.1 1104.7 1127.5 1130.0 18703.4 19199.0 19413.6 19415.6 19671.2 50849.7 52279.7 53294.0 55345.4 55933.0 76239.6 79086.6 79425.0 79445.6 80069.2 7010.3 7058.3 8062.4 8272.4 8444.8 10243.5 12433.6 13203.0 13476.5 13525.5 10602.3 10694.3 11527.1 11667.1 11741.5 11429.8 11457.7 11524.7 11528.8 11637.8 11678.2 11703.6 11859.2 12046.8 12049.2 8220.6 8223.4 8415.9 8518.7 8636.5 11362.8 11762.6 11822.3 11983.5 12012.5 08:12:38 INFO - PROCESS | 1668 | 08:12:38 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:6259.31 Median:3038.77 stddev:3313.77 (109.0%) stddev-sans-first:3303.70 08:12:38 INFO - PROCESS | 1668 | Values: 1492.4 1609.1 1610.3 1934.8 2072.2 8306.7 8513.0 8517.4 8522.1 8524.1 8811.0 9033.7 9036.5 9038.1 9054.7 2131.7 2509.3 2576.3 2576.9 2578.7 2186.2 2556.9 2630.4 2634.6 2635.9 2534.9 2547.8 2594.7 2599.2 2600.7 2211.9 2552.7 2553.5 2576.3 2580.1 2604.8 2615.6 2642.1 2643.3 2655.2 9131.5 9175.8 9176.6 9201.4 9218.7 5525.8 5689.8 5738.4 5748.6 5759.2 3633.6 3771.2 3773.0 3778.3 3842.4 909.8 1098.6 1103.0 1105.8 1114.8 12246.7 12477.6 12478.6 12500.9 12558.9 5004.5 5059.8 5156.3 5162.5 5162.5 10754.9 10775.5 10781.6 10782.9 10791.7 5733.9 5796.8 5809.4 5813.5 5813.6 4634.4 4642.8 4731.2 4734.9 5228.7 4073.6 4092.3 4146.4 4161.4 4178.8 1215.6 1298.8 1366.5 1369.8 1377.5 1401.9 1434.3 1442.7 1452.6 1457.9 8360.5 8432.0 8449.0 8534.8 8553.1 533.6 539.9 546.5 551.7 553.9 6352.6 6399.3 6402.8 6435.9 6435.9 10906.7 11290.0 11293.3 11306.9 11311.9 10255.6 10758.9 10947.7 10990.3 11110.6 8440.8 8466.0 8569.4 8573.6 8593.7 8286.5 8287.9 8334.7 8417.2 8451.0 9390.2 9792.1 9852.6 9867.0 9910.4 9753.7 9874.3 10081.6 10091.0 10148.9 7052.8 7479.6 7503.1 7631.6 7667.8 8524.6 8538.5 8563.1 8566.9 8587.9 7453.1 7524.6 7546.0 7639.4 7715.2 7452.5 7454.1 7470.1 7533.0 7577.0 7894.8 7967.2 7968.2 8025.3 8066.3 7222.2 7270.9 7275.0 7303.5 7317.5 7400.3 7423.2 7468.6 7473.3 7476.7 08:12:38 INFO - PROCESS | 1668 | 08:12:38 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:5827.97 Median:6742.10 stddev:1836.08 (27.2%) stddev-sans-first:1794.32 08:12:38 INFO - PROCESS | 1668 | Values: 333.6 339.8 344.3 346.9 349.9 6763.1 6776.3 6811.0 6839.6 6857.3 5830.1 6363.3 6728.3 6732.8 6733.2 4754.9 4833.6 4874.2 4982.4 5058.9 4935.6 4986.1 4987.2 4990.6 5005.1 4946.5 4949.6 4958.9 4959.3 4966.7 4769.8 4858.4 4938.2 4963.7 4965.2 4285.3 4288.7 4289.6 4297.1 4306.1 6468.6 6470.1 6487.0 6490.1 6507.5 5859.8 5864.1 5871.0 5873.6 5874.9 6832.8 7101.9 7113.1 7114.9 7122.9 4614.5 4618.1 4622.5 4634.3 4647.2 7393.9 7496.0 7505.1 7517.9 7526.0 4708.8 4715.0 4725.9 4726.8 4738.5 4769.5 4774.5 4779.0 4780.7 4787.3 5451.3 5680.1 5686.8 5701.7 5715.7 7127.7 7134.4 7143.3 7162.9 7179.7 1382.4 1620.3 1661.3 1661.7 1664.2 995.3 1011.1 1036.2 1049.0 1110.4 6714.8 6751.0 6767.8 6776.9 6778.1 5935.4 7355.2 7359.2 7378.9 7390.2 6728.8 6760.2 6773.6 6774.1 6774.5 3751.3 3857.1 3898.6 3902.9 3910.2 7646.6 7667.3 7674.3 7682.7 7699.7 7503.6 7528.8 7542.4 7557.3 7577.8 6172.7 7599.9 7635.4 7638.2 7644.5 7068.9 7317.6 7327.8 7335.2 7340.4 7168.1 7179.4 7198.1 7198.4 7251.8 6124.8 7609.0 7629.2 7629.5 7637.0 4918.6 4940.5 4943.7 4949.3 4954.6 7044.3 7287.7 7299.6 7318.4 7330.0 7014.5 7055.6 7056.2 7060.6 7105.4 7041.9 7042.2 7062.8 7062.8 7063.2 5602.9 6907.6 6910.9 6916.9 6918.9 6724.8 6994.4 7040.2 7040.8 7072.0 6753.4 6907.1 6915.3 6979.3 7062.6 08:12:38 INFO - PROCESS | 1668 | 08:12:38 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:18814.63 Median:25825.03 stddev:26610.67 (103.0%) stddev-sans-first:26650.60 08:12:38 INFO - PROCESS | 1668 | Values: 712.4 752.9 770.8 772.8 800.2 14633.3 14870.7 14952.0 14979.9 14980.8 14194.1 14317.7 14373.5 14386.9 14406.8 812.8 834.0 966.9 967.8 971.4 955.8 956.8 964.9 965.2 985.6 868.2 1020.3 1021.4 1025.5 1041.0 1022.7 1040.0 1041.6 1044.0 1045.6 769.4 775.5 778.5 778.8 779.7 15202.2 15259.8 15264.2 15308.1 15309.2 11956.6 12746.2 12864.8 12878.6 13088.7 10143.0 10195.6 10263.1 10562.7 10639.2 3478.8 3495.1 3520.0 3563.4 3737.6 83216.0 83982.3 84048.6 84203.0 84235.6 9966.8 10008.9 10011.9 10044.6 10096.1 22343.9 22446.9 22453.7 22557.9 22590.0 7763.0 7801.1 7840.1 7976.2 7978.8 4244.2 4255.1 4331.5 4549.6 4594.9 3595.1 3692.9 3704.0 3734.3 3749.7 666.4 668.1 670.5 673.0 686.2 516.3 539.9 553.2 593.2 596.2 7791.9 8120.0 8171.3 8232.3 8279.5 500.2 580.7 591.2 605.7 608.1 3810.1 3817.5 3874.7 3875.8 4060.8 92198.5 93698.1 94737.1 96488.0 96624.0 80748.6 81599.0 83535.6 83736.6 84155.6 73523.6 74091.0 74163.6 74356.3 76312.2 7487.6 7561.6 7652.5 7956.7 8212.8 40558.0 51133.7 51650.5 51755.2 51874.7 56792.7 67399.0 69377.7 70811.0 71264.2 10490.3 11250.2 11272.4 11282.2 11707.4 11961.9 12133.3 12162.1 12770.0 13500.3 11659.4 11906.3 11915.7 12120.2 12230.0 11601.4 11645.6 11923.0 12005.2 12067.3 11458.7 11578.8 11635.5 11689.1 12125.0 8097.2 9392.6 9534.8 9758.5 9764.3 9486.5 9725.2 9747.6 9831.3 9834.0 08:12:38 INFO - PROCESS | 1668 | -------- Summary: end -------- 08:12:38 INFO - PROCESS | 1668 | 08:12:39 INFO - TEST-INFO | 1668: exit 0 08:12:39 INFO - TEST-OK | dromaeo_css | took 1112410ms 08:12:39 INFO - TEST-START | kraken 08:12:39 INFO - operating with platform_type : mac_ 08:12:39 INFO - Initialising browser for kraken test... 08:12:39 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/tmptl5_W9/profile http://localhost:49276/getInfo.html) 08:12:41 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 08:12:41 INFO - PROCESS | 1675 | colorDepth:24 08:12:41 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 08:12:41 INFO - PROCESS | 1675 | __metrics 08:12:41 INFO - PROCESS | 1675 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:12:41 INFO - PROCESS | 1675 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:12:42 INFO - TEST-INFO | 1675: exit 0 08:12:42 INFO - Browser initialized. 08:12:42 INFO - Running cycle 1/1 for kraken test... 08:12:42 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/tmptl5_W9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:12:54 INFO - PROCESS | 1678 | RSS: Main: 157331456 08:12:54 INFO - PROCESS | 1678 | 08:12:56 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 08:12:57 INFO - PROCESS | 1678 | RSS: Main: 218210304 08:12:57 INFO - PROCESS | 1678 | 08:13:00 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 08:13:00 INFO - PROCESS | 1678 | RSS: Main: 228745216 08:13:00 INFO - PROCESS | 1678 | 08:13:03 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 08:13:04 INFO - PROCESS | 1678 | RSS: Main: 218214400 08:13:04 INFO - PROCESS | 1678 | 08:13:06 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 08:13:06 INFO - PROCESS | 1678 | RSS: Main: 220389376 08:13:06 INFO - PROCESS | 1678 | 08:13:09 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:13:09 INFO - PROCESS | 1678 | RSS: Main: 220348416 08:13:09 INFO - PROCESS | 1678 | 08:13:12 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 08:13:13 INFO - PROCESS | 1678 | RSS: Main: 220176384 08:13:13 INFO - PROCESS | 1678 | 08:13:15 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 08:13:16 INFO - PROCESS | 1678 | RSS: Main: 220487680 08:13:16 INFO - PROCESS | 1678 | 08:13:19 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 08:13:19 INFO - PROCESS | 1678 | RSS: Main: 220643328 08:13:19 INFO - PROCESS | 1678 | 08:13:21 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:13:22 INFO - PROCESS | 1678 | RSS: Main: 255393792 08:13:22 INFO - PROCESS | 1678 | 08:13:23 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:13:24 INFO - PROCESS | 1678 | RSS: Main: 256036864 08:13:24 INFO - PROCESS | 1678 | 08:13:26 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:13:27 INFO - PROCESS | 1678 | RSS: Main: 260935680 08:13:27 INFO - PROCESS | 1678 | 08:13:29 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:13:30 INFO - PROCESS | 1678 | RSS: Main: 262766592 08:13:30 INFO - PROCESS | 1678 | 08:13:32 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:13:33 INFO - PROCESS | 1678 | RSS: Main: 262807552 08:13:33 INFO - PROCESS | 1678 | 08:13:35 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 08:13:35 INFO - PROCESS | 1678 | RSS: Main: 325861376 08:13:35 INFO - PROCESS | 1678 | 08:13:35 INFO - PROCESS | 1678 | __start_tp_report 08:13:35 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 08:13:35 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 08:13:35 INFO - PROCESS | 1678 | |i|pagename|runs| 08:13:35 INFO - PROCESS | 1678 | |0;ai-astar;111;112;110;111;112;111;128;111;109;111 08:13:35 INFO - PROCESS | 1678 | |1;audio-beat-detection;161;156;187;147;116;138;116;166;130;155 08:13:35 INFO - PROCESS | 1678 | |2;audio-dft;183;181;181;180;183;186;183;185;181;183 08:13:35 INFO - PROCESS | 1678 | |3;audio-fft;73;78;71;110;56;74;74;82;148;46 08:13:35 INFO - PROCESS | 1678 | |4;audio-oscillator;89;94;166;114;62;82;144;113;117;154 08:13:35 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;87;90;110;86;86;80;86;84;86;83 08:13:35 INFO - PROCESS | 1678 | |6;imaging-darkroom;92;91;93;92;92;92;91;92;92;93 08:13:35 INFO - PROCESS | 1678 | |7;imaging-desaturate;83;85;84;82;87;112;133;133;90;88 08:13:35 INFO - PROCESS | 1678 | |8;json-parse-financial;56;58;58;56;57;57;58;57;68;52 08:13:35 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;63;62;70;77;68;67;64;64;65;65 08:13:35 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;81;80;105;105;107;96;80;81;80;85 08:13:35 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;121;131;110;122;127;121;121;128;121;124 08:13:35 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;135;121;133;131;131;133;134;132;158;133 08:13:35 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;66;64;64;66;64;66;66;65;64;64 08:13:35 INFO - PROCESS | 1678 | __end_tp_report 08:13:35 INFO - PROCESS | 1678 | __start_cc_report 08:13:35 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1197 08:13:35 INFO - PROCESS | 1678 | __end_cc_report 08:13:35 INFO - PROCESS | 1678 | __startTimestamp1464275615294__endTimestamp 08:13:35 INFO - PROCESS | 1678 | 08:13:35 INFO - PROCESS | 1678 | ------- Summary: start ------- 08:13:35 INFO - PROCESS | 1678 | Number of tests: 14 08:13:35 INFO - PROCESS | 1678 | 08:13:35 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:112.60 Median:111.00 stddev:5.48 (4.9%) stddev-sans-first:5.78 08:13:35 INFO - PROCESS | 1678 | Values: 111.0 112.0 110.0 111.0 112.0 111.0 128.0 111.0 109.0 111.0 08:13:35 INFO - PROCESS | 1678 | 08:13:35 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:155.50 stddev:22.59 (14.5%) stddev-sans-first:23.40 08:13:35 INFO - PROCESS | 1678 | Values: 161.0 156.0 187.0 147.0 116.0 138.0 116.0 166.0 130.0 155.0 08:13:35 INFO - PROCESS | 1678 | 08:13:35 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:182.60 Median:183.00 stddev:1.90 (1.0%) stddev-sans-first:2.01 08:13:35 INFO - PROCESS | 1678 | Values: 183.0 181.0 181.0 180.0 183.0 186.0 183.0 185.0 181.0 183.0 08:13:35 INFO - PROCESS | 1678 | 08:13:35 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:81.20 Median:73.50 stddev:28.77 (39.1%) stddev-sans-first:30.37 08:13:35 INFO - PROCESS | 1678 | Values: 73.0 78.0 71.0 110.0 56.0 74.0 74.0 82.0 148.0 46.0 08:13:35 INFO - PROCESS | 1678 | 08:13:35 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:113.50 Median:114.00 stddev:33.27 (29.2%) stddev-sans-first:34.09 08:13:35 INFO - PROCESS | 1678 | Values: 89.0 94.0 166.0 114.0 62.0 82.0 144.0 113.0 117.0 154.0 08:13:35 INFO - PROCESS | 1678 | 08:13:35 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:87.80 Median:86.00 stddev:8.23 (9.6%) stddev-sans-first:8.72 08:13:35 INFO - PROCESS | 1678 | Values: 87.0 90.0 110.0 86.0 86.0 80.0 86.0 84.0 86.0 83.0 08:13:35 INFO - PROCESS | 1678 | 08:13:35 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:92.00 Median:92.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 08:13:35 INFO - PROCESS | 1678 | Values: 92.0 91.0 93.0 92.0 92.0 92.0 91.0 92.0 92.0 93.0 08:13:35 INFO - PROCESS | 1678 | 08:13:35 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:97.70 Median:84.50 stddev:20.48 (24.2%) stddev-sans-first:21.02 08:13:35 INFO - PROCESS | 1678 | Values: 83.0 85.0 84.0 82.0 87.0 112.0 133.0 133.0 90.0 88.0 08:13:35 INFO - PROCESS | 1678 | 08:13:35 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.50 stddev:4.03 (7.0%) stddev-sans-first:4.23 08:13:35 INFO - PROCESS | 1678 | Values: 56.0 58.0 58.0 56.0 57.0 57.0 58.0 57.0 68.0 52.0 08:13:35 INFO - PROCESS | 1678 | 08:13:35 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:66.00 stddev:4.40 (6.7%) stddev-sans-first:4.48 08:13:35 INFO - PROCESS | 1678 | Values: 63.0 62.0 70.0 77.0 68.0 67.0 64.0 64.0 65.0 65.0 08:13:35 INFO - PROCESS | 1678 | 08:13:35 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:90.00 Median:80.50 stddev:11.84 (14.7%) stddev-sans-first:12.10 08:13:35 INFO - PROCESS | 1678 | Values: 81.0 80.0 105.0 105.0 107.0 96.0 80.0 81.0 80.0 85.0 08:13:35 INFO - PROCESS | 1678 | 08:13:35 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:122.60 Median:123.00 stddev:5.68 (4.6%) stddev-sans-first:6.00 08:13:35 INFO - PROCESS | 1678 | Values: 121.0 131.0 110.0 122.0 127.0 121.0 121.0 128.0 121.0 124.0 08:13:35 INFO - PROCESS | 1678 | 08:13:35 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.10 Median:133.00 stddev:9.26 (7.0%) stddev-sans-first:9.81 08:13:35 INFO - PROCESS | 1678 | Values: 135.0 121.0 133.0 131.0 131.0 133.0 134.0 132.0 158.0 133.0 08:13:35 INFO - PROCESS | 1678 | 08:13:35 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.50 stddev:0.99 (1.5%) stddev-sans-first:0.97 08:13:35 INFO - PROCESS | 1678 | Values: 66.0 64.0 64.0 66.0 64.0 66.0 66.0 65.0 64.0 64.0 08:13:35 INFO - PROCESS | 1678 | -------- Summary: end -------- 08:13:35 INFO - PROCESS | 1678 | 08:13:35 INFO - TEST-INFO | 1678: exit 0 08:13:36 INFO - TEST-OK | kraken | took 56491ms 08:13:36 INFO - SUITE-END | took 1168s 08:13:36 INFO - Completed test suite (00:19:29) 08:13:36 INFO - javascript benchmark 08:13:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3509.15780212749, 3517.40204165292, 3549.272399158173, 3591.479235510851, 3606.441001644745, 5700.686462244575, 5732.054211055181, 5749.166370876221, 5753.971230143843, 5781.884362312751, 5710.914336284959, 5763.5389168866495, 5773.653580785156, 5775.480206781389, 5806.912896306549, 5164.483551644824, 5240.082985477527, 5265.262863199146, 5291.735413229323, 5383.542398896079, 5305.204219367087, 5323.0152421801895, 5330.520253177213, 5330.866728331784, 5331.306930099082, 4225.492940847103, 5263.0, 5267.078261304257, 5292.020976119411, 5306.602004849632, 5317.096093664087, 5348.465153484659, 5354.973225133888, 5362.785488580452, 5376.731163441851, 5100.7959681613065, 5264.9736751315995, 5274.789008439658, 5277.8416647500635, 5280.07598670235, 5646.887062258732, 5675.716214189315, 5690.146478028288, 5701.287339082614, 5728.68492232927, 6163.691815409212, 6305.905411418832, 6324.7470101195895, 6336.176297081396, 6356.491480681534, 6240.188775459206, 6250.749970001195, 6263.279722831887, 6289.8742025159245, 6334.588251763621, 5919.704014799243, 5972.044472884361, 5974.074018527135, 5975.731092100866, 6012.488938440194, 6237.937620623736, 6344.206974128234, 6349.0, 6363.077353783768, 6492.09110724499, 6112.358202388774, 6232.501399887998, 6255.499560035186, 6263.874722505524, 6323.30443651198, 6293.716782744696, 6325.9051114233325, 6330.240371155399, 6334.778282760173, 6345.0482427636225, 6122.947104152868, 6215.782447614311, 6253.6560489172625, 6316.178896743394, 6325.620462772248, 6215.160953271251, 6224.221972253468, 6232.657203853741, 6265.154204182377, 6329.620222786648, 4981.32752078472, 4987.875303117378, 4988.90022199554, 4993.026359859865, 5035.194368901031, 4486.641068714495, 4497.707649002804, 4515.706479078849, 4543.432070991126, 4548.408706868086, 5791.739371728198, 5825.912611310834, 5876.853078673067, 5899.056151015817, 5969.462748352669, 6318.210223722035, 6325.430711235919, 6329.651869147241, 6352.047192921006, 6359.300476947532, 5913.526917846562, 5952.114121203964, 5953.077273022688, 5963.880722385528, 5964.671943043088, 5337.86655333612, 5344.278522399426, 5390.703511306838, 5436.728163591804, 5492.5331346835965, 6343.619382837044, 6358.809235722843, 6363.61818290904, 6368.554201205871, 6372.968135159294, 6260.280067792262, 6306.180196574416, 6311.400416960381, 6331.240251169889, 6340.207474065742, 6270.404311590391, 6331.145295385249, 6339.2392912850755, 6376.74493020274, 6378.425941665272, 6238.594491358229, 6255.0, 6298.464630506458, 6301.212348456443, 6313.463355614824, 6211.068339749074, 6313.842153946004, 6322.178116844781, 6327.557071004985, 6342.175517182736, 6063.909041364472, 6073.635581865102, 6129.35641757609, 6130.000698177663, 6133.478654314434, 6157.907631385622, 6185.659743738331, 6190.81427557174, 6213.099100630293, 6216.098665693539, 5832.096025116114, 5846.35690074083, 6086.452219300284, 6105.786297479567, 6107.541934354852, 6055.666938318434, 6116.674139391257, 6131.866048757478, 6135.085739396129, 6136.839527643178, 6096.969515152396, 6097.390260973867, 6131.110988906673, 6137.079438084323, 6151.231096112986], "unit": "score", "name": "dojo.html", "value": 5784.279446413249}, {"lowerIsBetter": false, "replicates": [472.63607022592606, 550.7383992603517, 575.59708204257, 603.5895590998123, 675.864547560099, 32534.0, 40660.0, 40711.38932916008, 40834.38748418776, 40887.38668919969, 43678.781606092, 44471.555284447146, 44493.55506444935, 44554.10891782162, 44637.0, 9723.708288751348, 9949.204063674888, 9955.352902061379, 9962.601495940155, 9971.650992215275, 9744.707658770212, 9873.703788886309, 9892.40645561265, 9978.0, 9981.90018099817, 9932.35439696421, 9972.451515166664, 9976.05227503386, 9983.750406239866, 9986.600535978589, 9856.753581160458, 9930.006999300085, 9943.651972181011, 9962.701118966406, 9984.0, 9791.0, 9909.65316213929, 9929.404235745878, 9940.254480913887, 9954.104130628279, 40936.79531602353, 42788.78605606983, 43327.78336108331, 43490.0, 43512.0, 3247.382997230519, 3444.810535420551, 3475.5134281200653, 3724.478572999782, 3930.410438434229, 29207.707922920923, 29934.700652993626, 30058.398832023457, 30096.548551771742, 30723.0, 2799.6360473138566, 2829.1795379339965, 2876.769858411343, 2896.4496745618476, 2943.705629437039, 391046.0, 391413.0, 392073.0792692065, 392657.0, 392681.0, 65987.67006164939, 66033.6698316515, 66421.6715665684, 66472.33527664661, 66726.33273667298, 75773.62113189399, 76850.2314976843, 76858.6157069211, 77150.0, 77338.61330693311, 15776.447824326093, 18764.343247986257, 18941.621167576846, 18944.052797360077, 18966.431007069536, 14198.432062717582, 14318.0, 14327.856721432652, 14330.49843255481, 14351.0, 22092.00585973635, 22390.44023899383, 22456.214032508782, 22481.775182248297, 22899.771002289763, 8877.378583499092, 9282.90717092834, 9505.667301644547, 9516.571754271074, 9545.665901693408, 888.3692578269502, 1008.4655132779639, 1059.9682009539727, 1067.3595842494442, 1161.0537412009185, 29489.705102949127, 29571.0, 30154.24614384658, 30695.23261918425, 30897.0, 1127.7800828838463, 1161.6108603617884, 1201.873803250646, 1212.2908098762323, 1263.9115261931577, 14682.412703491955, 14743.0, 14864.851351486563, 14865.331060102322, 14930.178840163895, 642882.0, 659343.0, 659877.0, 663214.0, 668035.319646807, 60711.69644151751, 61461.69269153626, 61482.69258653678, 61483.69258153681, 61516.0, 1414.5049232768654, 1512.5916002679214, 1529.831718510963, 1550.317860141534, 1551.3949559671737, 27992.44015119727, 29635.259118522208, 29657.5551366734, 30146.69853301439, 31297.687023129478, 49727.0, 50274.24588631246, 50290.748546258495, 50442.24336635027, 50479.24281135859, 421717.0, 422504.0, 427939.0, 428960.0, 429168.0, 34304.65695343114, 45461.0, 45763.77118114388, 47873.281900772214, 47891.04217915692, 45311.320330194416, 45598.54401455943, 46129.30806037845, 47045.29432058454, 47169.76415117903, 36381.45427818638, 36692.63307366892, 37698.2460350786, 39422.817315480585, 39525.80237098796, 35012.649873501956, 38819.41770873496, 38963.08090357272, 39163.804180978914, 39780.403293951196, 38083.0, 38864.417033745085, 38917.80541097277, 39080.804595976835, 39595.80202098971, 33735.3252934935, 34310.0, 34338.82830585831, 34504.65495345015, 34589.48115778215, 21836.0, 25195.0, 25974.961001559725, 25980.740192598587, 25994.0], "unit": "score", "name": "ext.html", "value": 20830.251429821732}, {"lowerIsBetter": false, "replicates": [380.29834954508937, 384.22195055013594, 384.58080692045667, 388.75702685821364, 390.50991006287103, 20233.39299821006, 21176.89411552942, 21186.364409067715, 21862.344129676094, 21876.45308867279, 21319.040643171054, 21347.825869577206, 21410.822404767732, 21712.457188570294, 21930.780692193075, 5792.7972520961775, 5857.4435428634215, 6064.514838812906, 6066.998945174041, 6121.173641558399, 4125.195586860564, 4316.330968699841, 5855.707214639272, 6088.4215999479975, 6093.786717464867, 6040.395960403968, 6073.574849760496, 6080.14877917092, 6086.695665216744, 6087.0, 5885.47030767233, 5942.316633587128, 6034.909476357858, 6038.69806509675, 6040.275166979946, 5498.890022199574, 5679.7160141993145, 5753.194552762617, 5758.136279558058, 5776.566757493205, 13977.3710183042, 14353.856461435356, 14400.927995359956, 14414.855851441456, 14437.494687685881, 2181.9345419637434, 2272.874991875446, 2314.4329639238326, 2418.3954011497126, 2667.186508115024, 10041.447720375376, 10151.137153341975, 10535.367877927349, 10546.630867919586, 10660.573577056908, 1526.9389224431009, 1705.4031089118832, 1752.824717528237, 1827.5339788354017, 1833.6516061948187, 108978.0, 113797.4310128444, 115882.42058789651, 116335.83664163334, 117224.41387793091, 11563.07495400366, 11625.069994400428, 11670.299782013106, 11702.88297117035, 11807.173497855068, 14392.992490525772, 14418.062825916282, 14457.710845783025, 14474.927625362016, 14491.565253042425, 8714.825703485894, 9027.052159523155, 9048.321375896703, 9105.271578273854, 9131.589078491485, 9369.859452108223, 9386.67146649864, 9391.953040234755, 9476.715698529055, 9481.4785186814, 4513.480949690762, 4595.425571803525, 4596.49438561758, 4635.443746750411, 4644.419447569054, 1582.272154808801, 1770.6812773700858, 1836.939232414689, 1901.8003109673562, 1903.9428817135508, 938.7136923238478, 971.708487453761, 1000.6491236830221, 1028.6399760083912, 1121.170333952869, 19249.903750481437, 20237.190512379635, 20310.172084512466, 20353.185872564933, 20577.794222057586, 770.849684311565, 990.3513198854762, 1008.8184126857236, 1024.359775140537, 1029.063552167524, 10918.836217456745, 11278.154138439486, 11389.886101139049, 11512.76974460506, 12285.815712764315, 661028.0, 666881.0, 670549.0, 674210.0, 675533.0, 117017.0, 125020.0, 126717.92287620193, 126762.0, 129906.70093298946, 1098.1873413673984, 1102.0577406317643, 1104.6520346090956, 1127.537709539085, 1129.9661010169543, 18703.438896833115, 19199.0, 19413.611727765085, 19415.611687765882, 19671.21315147378, 50849.7287567799, 52279.73860130675, 53294.0, 55345.44654553403, 55933.0, 76239.61880190785, 79086.60456697679, 79425.0, 79445.60277198577, 80069.19930800618, 7010.298970102949, 7058.294170582901, 8062.39532035088, 8272.420930535045, 8444.831103378021, 10243.487825608541, 12433.564825231073, 13203.0, 13476.460941562227, 13525.458981641017, 10602.310849794738, 10694.251402401756, 11527.135464840003, 11667.066634669376, 11741.471633776671, 11429.828552571884, 11457.713557161138, 11524.711882203012, 11528.769424611628, 11637.825432618349, 11678.182527223013, 11703.648890533297, 11859.229150105215, 12046.75906481848, 12049.216800907912, 8220.588970551567, 8223.424360294961, 8415.873761893454, 8518.70184543538, 8636.524991125549, 11362.829557556477, 11762.647120586396, 11822.290662560274, 11983.520659173535, 12012.519499219934], "unit": "score", "name": "jquery.html", "value": 9617.13326176699}, {"lowerIsBetter": false, "replicates": [1492.440334874422, 1609.1230279497672, 1610.3236640610942, 1934.8355389791875, 2072.2332736887356, 8306.66773329067, 8513.021002584705, 8517.36119791015, 8522.147785221474, 8524.14758524148, 8811.030786613468, 9033.728988130366, 9036.50299233542, 9038.051004644516, 9054.683086091987, 2131.7228760261223, 2509.3224829296123, 2576.265764257187, 2576.9355766105905, 2578.6905571331467, 2186.212963333199, 2556.910508132216, 2630.3950091478973, 2634.5784674452093, 2635.9472810543875, 2534.8605826679527, 2547.757962993522, 2594.688637363519, 2599.2462185966046, 2600.660659760225, 2211.9115235390564, 2552.719200887901, 2553.4510080332816, 2576.2528866628654, 2580.1098620975827, 2604.817662763607, 2615.6076588511687, 2642.1016854269446, 2643.2730998975244, 2655.2034389683017, 9131.497767622777, 9175.77060573491, 9176.632934682604, 9201.401908875969, 9218.723438296862, 5525.834224973257, 5689.829305120812, 5738.42615738427, 5748.626339287975, 5759.1937128802, 3633.6003039665616, 3771.226898485831, 3772.9622703772884, 3778.301014312361, 3842.385218365076, 909.8316811389914, 1098.5825386353215, 1103.0128035408345, 1105.7891608688474, 1114.8049091409052, 12246.693832654255, 12477.563285285063, 12478.563250286197, 12500.874991250063, 12558.937205313914, 5004.524570165829, 5059.772310246048, 5156.329677141947, 5162.53537181648, 5162.535371816554, 10754.946225268823, 10775.461226938778, 10781.62264320745, 10782.946085269681, 10791.730206744895, 5733.885322293614, 5796.82609521715, 5809.390014048464, 5813.476787089182, 5813.6221145625395, 4634.443866736014, 4642.79107440166, 4731.243001119804, 4734.905301893943, 5228.712420816892, 4073.5926407359025, 4092.283850326181, 4146.398772178018, 4161.396597493346, 4178.770167640748, 1215.6413857911937, 1298.8245637697898, 1366.5217173989024, 1369.7534443800012, 1377.5316392426623, 1401.8878489720798, 1434.2756907761723, 1442.65376309687, 1452.5932738833144, 1457.890658200639, 8360.45657032291, 8432.0, 8449.0, 8534.78663033429, 8553.101924297984, 533.6477924569765, 539.8650337415646, 546.4644648244742, 551.7020808763303, 553.9307586551681, 6352.587081839665, 6399.328070552618, 6402.807915762534, 6435.935640643534, 6435.938070218455, 10906.672799816019, 11290.0, 11293.265937714023, 11306.943465282786, 11311.94344028291, 10255.58977640901, 10758.892411075789, 10947.671569852917, 10990.285631433931, 11110.61112861046, 8440.788980275542, 8465.957670211732, 8569.400141990125, 8573.571321434029, 8593.742187734379, 8286.544240066854, 8287.875681864656, 8334.749957501284, 8417.242448179693, 8451.0, 9390.154886060287, 9792.069753373418, 9852.605895764089, 9866.950665246628, 9910.405375677483, 9753.707388778348, 9874.259430542594, 10081.647142349982, 10091.0, 10148.949255253676, 7052.788416347517, 7479.626018699152, 7503.062117235346, 7631.580263085583, 7667.808304792425, 8524.616392262487, 8538.530380828866, 8563.058063612873, 8566.871496927426, 8587.87118193215, 7453.105627324756, 7524.5861477619255, 7545.962270188614, 7639.350655194371, 7715.189905060112, 7452.515586486861, 7454.142773580891, 7470.140933792466, 7532.983047288546, 7577.0, 7894.84210315779, 7967.203279672218, 7968.163342848918, 8025.2777250047775, 8066.274035336613, 7222.169450513048, 7270.927290727025, 7275.0, 7303.488755787044, 7317.451191160578, 7400.333969942731, 7423.220561840929, 7468.589227592317, 7473.327400533978, 7476.738314158978], "unit": "score", "name": "mootools.html", "value": 5024.598351796456}, {"lowerIsBetter": false, "replicates": [333.5530389278367, 339.80461234790005, 344.2907610322734, 346.8924633363657, 349.8985294264663, 6763.05317255584, 6776.322367763221, 6811.012403201539, 6839.62382068986, 6857.31426857314, 5830.067189249721, 6363.268224154223, 6728.327167283269, 6732.831679208022, 6733.225679046911, 4754.90490190196, 4833.613310935134, 4874.195757699975, 4982.377202849644, 5058.949410505885, 4935.555799978001, 4986.10250154972, 4987.1521841286885, 4990.625703072266, 5005.074061298653, 4946.530079642428, 4949.579285760715, 4958.925616115761, 4959.256111583255, 4966.652334336598, 4769.785359658824, 4858.441279252896, 4938.2099114000475, 4963.702177869303, 4965.180745177042, 4285.314349704064, 4288.721233119837, 4289.571042895685, 4297.097609502009, 4306.074194048263, 6468.611883287018, 6470.09418681385, 6486.967565162191, 6490.05894145351, 6507.4794016479045, 5859.824205273806, 5864.061750120003, 5871.001929671966, 5873.559483038746, 5874.882502349929, 6832.760853370109, 7101.89347159793, 7113.110861142357, 7114.928850711479, 7122.92877071233, 4614.492405835355, 4618.0763847230355, 4622.514635963209, 4634.3048542718525, 4647.163510568096, 7393.926060739377, 7495.962520187419, 7505.099388073411, 7517.887231691474, 7525.962370188169, 4708.764561771966, 4714.976425117852, 4725.881852953635, 4726.763661816895, 4738.47876733559, 4769.451513076041, 4774.546418090275, 4778.95221047792, 4780.665353425296, 4787.281907713871, 5451.264079349237, 5680.147977803363, 5686.800961966312, 5701.686407247641, 5715.742791574389, 7127.7148914042855, 7134.429245660334, 7143.285671432815, 7162.92837071633, 7179.676914538753, 1382.3917476310592, 1620.3194658243567, 1661.2607389711704, 1661.651053278825, 1664.2095004872588, 995.318207028188, 1011.1455819832377, 1036.2073612650158, 1049.0, 1110.4447776111945, 6714.832129196711, 6750.966245168743, 6767.796966091025, 6776.898346524806, 6778.118844550177, 5935.376785437553, 7355.190928997913, 7359.153697324876, 7378.852422951618, 7390.22402647725, 6728.831779205461, 6760.222574403908, 6773.593584384953, 6774.051632771416, 6774.525783195228, 3751.3060083884025, 3857.1128640412862, 3898.6101389861356, 3902.941455878164, 3910.159315747128, 7646.617669116522, 7667.271609197229, 7674.270944260286, 7682.693942029869, 7699.730509432143, 7503.5873026982945, 7528.774136775905, 7542.358899493604, 7557.319841214207, 7577.810554736176, 6172.722227499773, 7599.886001709979, 7635.389168866477, 7638.159802421618, 7644.50310729823, 7068.929310706827, 7317.634118293958, 7327.780166595011, 7335.1564570075125, 7340.412766978522, 7168.103987001625, 7179.425645948416, 7198.136223653195, 7198.388137008413, 7251.782446526613, 6124.816255512342, 7609.048868891388, 7629.2370762923265, 7629.504082234637, 7637.045369328834, 4918.631102667386, 4940.505949405031, 4943.678660887031, 4949.30709700635, 4954.5540901319055, 7044.295570442915, 7287.672054757442, 7299.598522081336, 7318.377937875341, 7330.0, 7014.5440546364325, 7055.576665400093, 7056.188538318159, 7060.6116663584, 7105.396041336544, 7041.894371584533, 7042.190148133031, 7062.8234294141, 7062.823429414306, 7063.1524217094275, 5602.943970560243, 6907.585544867324, 6910.93089069123, 6916.930830691628, 6918.93081069203, 6724.7646332378135, 6994.370506654425, 7040.155181378267, 7040.788776336718, 7071.964640176766, 6753.358430949052, 6907.13660792401, 6915.308469153246, 6979.336962988508, 7062.646867656494], "unit": "score", "name": "prototype.html", "value": 5209.16825220941}, {"lowerIsBetter": false, "replicates": [712.3873468816817, 752.8833030880215, 770.788033290845, 772.8338407242442, 800.2397722163946, 14633.341499632515, 14870.702585948275, 14951.999999999987, 14979.850201497982, 14980.801535877132, 14194.077384969996, 14317.713645727079, 14373.49692760751, 14386.856131438708, 14406.783898241509, 812.7642983534782, 833.9916600833975, 966.9081437263449, 967.796762679838, 971.3540495570472, 955.8231727130468, 956.8373376525973, 964.8600952861831, 965.1651321606795, 985.5515740338129, 868.2186032570673, 1020.2603112743276, 1021.3973755484262, 1025.4821315235795, 1040.994795026024, 1022.693192042388, 1039.9584016639362, 1041.6146025970363, 1043.9582416703322, 1045.5556388534842, 769.4114002787871, 775.53467919248, 778.4550814429922, 778.8247644280049, 779.6530543907963, 15202.239888005666, 15259.847401525954, 15264.16047117408, 15308.081515109128, 15309.157996310198, 11956.641300760992, 12746.235225886476, 12864.807027894589, 12878.613641590768, 13088.738225235536, 10143.036411540892, 10195.592176312939, 10263.07632313088, 10562.683119506428, 10639.202059845542, 3478.843452044639, 3495.10874726943, 3520.0319912024142, 3563.4120370139153, 3737.635762946532, 83216.0, 83982.3203535932, 84048.57975710144, 84203.0, 84235.57882210611, 9966.750831229132, 10008.949955250177, 10011.949940250252, 10044.648437304659, 10096.14182794456, 22343.88280585964, 22446.887765561067, 22453.663195052086, 22557.887210563844, 22589.983450744756, 7762.961185194038, 7801.141874393812, 7840.09838868526, 7976.162502937224, 7978.800529986796, 4244.236037513216, 4255.085156691264, 4331.45856767904, 4549.613282870927, 4594.908101837945, 3595.065283026432, 3692.8707495237536, 3703.9629603704157, 3734.2531493700826, 3749.7000239980734, 666.4435196610788, 668.0580381661833, 670.483727529809, 672.9831754206086, 686.1663079358603, 516.3107251818789, 539.9433059528772, 553.1868153813887, 593.2465768474013, 596.2219303808484, 7791.883121753178, 8120.025596928288, 8171.264586187272, 8232.34141268697, 8279.512864868042, 500.2446306077776, 580.6835274775258, 591.1753104419311, 605.6941244671413, 608.0969759906535, 3810.0855794609647, 3817.541894972621, 3874.670652994471, 3875.806209689504, 4060.796960151981, 92198.53900730453, 93698.06301936893, 94737.0526294742, 96488.0, 96624.03375966291, 80748.59625701833, 81599.0, 83535.582322088, 83736.58131709424, 84155.5792221035, 73523.63238183882, 74091.0, 74163.62918185374, 74356.25643743601, 76312.23687763051, 7487.625618719151, 7561.621918904143, 7652.502587331805, 7956.681732730857, 8212.794680132805, 40558.0, 51133.7443312781, 51650.45048648547, 51755.22367164571, 51874.740626296625, 56792.71603641955, 67399.0, 69377.65311173412, 70811.0, 71264.21839454056, 10490.265681402228, 11250.21248512629, 11272.380019099028, 11282.153838461983, 11707.414629268333, 11961.880381196077, 12133.272003679807, 12162.148649594797, 12770.0, 13500.25748583798, 11659.358735269641, 11906.285622862655, 11915.702107447383, 12120.212186207867, 12230.0, 11601.361925094201, 11645.59240426581, 11923.0, 12005.159638825198, 12067.275963442222, 11458.713532161762, 11578.76842463163, 11635.53457861676, 11689.123315751523, 12125.029997600348, 8097.2307630774985, 9392.624295028123, 9534.809303813747, 9758.46328451942, 9764.267679924176, 9486.525673716425, 9725.221982241545, 9747.561359738971, 9831.311808173645, 9833.950830246089], "unit": "score", "name": "yui.html", "value": 7097.024662971475}], "name": "dromaeo_css", "value": 7741.560130537285}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 110.0, 111.0, 112.0, 111.0, 128.0, 111.0, 109.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.6}, {"lowerIsBetter": true, "replicates": [161.0, 156.0, 187.0, 147.0, 116.0, 138.0, 116.0, 166.0, 130.0, 155.0], "unit": "score", "name": "audio-beat-detection", "value": 147.2}, {"lowerIsBetter": true, "replicates": [183.0, 181.0, 181.0, 180.0, 183.0, 186.0, 183.0, 185.0, 181.0, 183.0], "unit": "score", "name": "audio-dft", "value": 182.6}, {"lowerIsBetter": true, "replicates": [73.0, 78.0, 71.0, 110.0, 56.0, 74.0, 74.0, 82.0, 148.0, 46.0], "unit": "score", "name": "audio-fft", "value": 81.2}, {"lowerIsBetter": true, "replicates": [89.0, 94.0, 166.0, 114.0, 62.0, 82.0, 144.0, 113.0, 117.0, 154.0], "unit": "score", "name": "audio-oscillator", "value": 113.5}, {"lowerIsBetter": true, "replicates": [87.0, 90.0, 110.0, 86.0, 86.0, 80.0, 86.0, 84.0, 86.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.8}, {"lowerIsBetter": true, "replicates": [92.0, 91.0, 93.0, 92.0, 92.0, 92.0, 91.0, 92.0, 92.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 92.0}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 84.0, 82.0, 87.0, 112.0, 133.0, 133.0, 90.0, 88.0], "unit": "score", "name": "imaging-desaturate", "value": 97.7}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 58.0, 56.0, 57.0, 57.0, 58.0, 57.0, 68.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 57.7}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 70.0, 77.0, 68.0, 67.0, 64.0, 64.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.5}, {"lowerIsBetter": true, "replicates": [81.0, 80.0, 105.0, 105.0, 107.0, 96.0, 80.0, 81.0, 80.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 90.0}, {"lowerIsBetter": true, "replicates": [121.0, 131.0, 110.0, 122.0, 127.0, 121.0, 121.0, 128.0, 121.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.6}, {"lowerIsBetter": true, "replicates": [135.0, 121.0, 133.0, 131.0, 131.0, 133.0, 134.0, 132.0, 158.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.1}, {"lowerIsBetter": true, "replicates": [66.0, 64.0, 64.0, 66.0, 64.0, 66.0, 66.0, 65.0, 64.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.9}], "name": "kraken", "value": 1450.4}]} 08:13:36 INFO - Return code: 0 08:13:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:13:36 INFO - # TBPL SUCCESS # 08:13:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:13:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:13:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:13:36 INFO - 2016-05-26 08:13:36.632 screenresolution[1682:9872] starting screenresolution argv=screenresolution get 08:13:36 INFO - 2016-05-26 08:13:36.634 screenresolution[1682:9872] Display 0: 1600x1200x32@60 08:13:36 INFO - 2016-05-26 08:13:36.639 screenresolution[1683:9875] starting screenresolution argv=screenresolution list 08:13:36 INFO - Available Modes on Display 0 08:13:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:13:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:13:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:13:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:13:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:13:36 INFO - Intel Iris: 08:13:36 INFO - Chipset Model: Intel Iris 08:13:36 INFO - Type: GPU 08:13:36 INFO - Bus: Built-In 08:13:36 INFO - VRAM (Dynamic, Max): 1536 MB 08:13:36 INFO - Vendor: Intel (0x8086) 08:13:36 INFO - Device ID: 0x0a2e 08:13:36 INFO - Revision ID: 0x0009 08:13:36 INFO - Displays: 08:13:36 INFO - Display: 08:13:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:13:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:13:36 INFO - Display Serial Number: 1600x1200 60 08:13:36 INFO - Main Display: Yes 08:13:36 INFO - Mirror: Off 08:13:36 INFO - Online: Yes 08:13:36 INFO - Rotation: Supported 08:13:36 INFO - Return code: 0 08:13:36 INFO - Running post-action listener: _resource_record_post_action 08:13:36 INFO - Running post-run listener: _resource_record_post_run 08:13:37 INFO - Total resource usage - Wall time: 1193s; CPU: 52.0%; Read bytes: 31096320; Write bytes: 506683392; Read time: 193; Write time: 1552 08:13:37 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 200776192; Write bytes: 197993984; Read time: 17927; Write time: 416 08:13:37 INFO - run-tests - Wall time: 1172s; CPU: 52.0%; Read bytes: 29314560; Write bytes: 297843200; Read time: 177; Write time: 1099 08:13:37 INFO - Running post-run listener: _upload_blobber_files 08:13:37 INFO - Blob upload gear active. 08:13:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:13:37 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:13:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:13:38 INFO - (blobuploader) - INFO - Open directory for files ... 08:13:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:13:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:13:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:13:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:13:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:13:39 INFO - (blobuploader) - INFO - Done attempting. 08:13:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:13:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:13:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:13:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:13:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:13:40 INFO - (blobuploader) - INFO - Done attempting. 08:13:40 INFO - (blobuploader) - INFO - Iteration through files over. 08:13:40 INFO - Return code: 0 08:13:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:13:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:13:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a6cd738eedfc1e14d2f53530b82079bd14aff7f97ba88c1df855eb1853fecd3eac72e3d64bb76119b711c374cecfc2cff14fee3ffb35c3714e7a6587ac61ebb2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a3481077fabf7cb97511945df8f40ee7b79982fb0403027db52897d20a5fe326e925b8b9b165b9c3d56caa8c0f62698a951df8776508573f829ae24973a6942a"} 08:13:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:13:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:13:40 INFO - Contents: 08:13:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a6cd738eedfc1e14d2f53530b82079bd14aff7f97ba88c1df855eb1853fecd3eac72e3d64bb76119b711c374cecfc2cff14fee3ffb35c3714e7a6587ac61ebb2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a3481077fabf7cb97511945df8f40ee7b79982fb0403027db52897d20a5fe326e925b8b9b165b9c3d56caa8c0f62698a951df8776508573f829ae24973a6942a"} 08:13:40 INFO - Running post-run listener: copy_logs_to_upload_dir 08:13:40 INFO - Copying logs to upload dir... 08:13:40 INFO - mkdir: /builds/slave/test/build/upload/logs 08:13:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.172495 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-05-26 08:13:40.557218) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 08:13:40.560953) ========= 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.U5krsy8vpS/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.fRzJkK2zSf/Listeners TMPDIR=/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a6cd738eedfc1e14d2f53530b82079bd14aff7f97ba88c1df855eb1853fecd3eac72e3d64bb76119b711c374cecfc2cff14fee3ffb35c3714e7a6587ac61ebb2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a3481077fabf7cb97511945df8f40ee7b79982fb0403027db52897d20a5fe326e925b8b9b165b9c3d56caa8c0f62698a951df8776508573f829ae24973a6942a"} build_url:https://queue.taskcluster.net/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011139 build_url: 'https://queue.taskcluster.net/v1/task/D9Nb2-JsQFOiTZ_xPzrijA/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a6cd738eedfc1e14d2f53530b82079bd14aff7f97ba88c1df855eb1853fecd3eac72e3d64bb76119b711c374cecfc2cff14fee3ffb35c3714e7a6587ac61ebb2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a3481077fabf7cb97511945df8f40ee7b79982fb0403027db52897d20a5fe326e925b8b9b165b9c3d56caa8c0f62698a951df8776508573f829ae24973a6942a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 08:13:40.593461) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 08:13:40.593936) ========= 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.U5krsy8vpS/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.fRzJkK2zSf/Listeners TMPDIR=/var/folders/fb/2vvs68mj0f558h69t2sk022r00000w/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.005255 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 08:13:40.644136) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 08:13:40.644448) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 08:13:40.644850) ========= ========= Total master_lag: 0.20 =========