builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0326 starttime: 1468475786.51 results: success (0) buildid: 20160713154642 builduid: 0219f93640ac4a39933847396c8d0f21 revision: 84c59d136a9e54be69571b75a19e8a8ccff7b8a1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 22:56:26.513198) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 22:56:26.513848) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 22:56:26.514198) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 22:56:26.539731) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 22:56:26.540037) ========= 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.SOoRzULKaB/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.uYCEYb4Mv6/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-13 22:56:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 17.1M=0.001s 2016-07-13 22:56:27 (17.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.509330 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 22:56:27.081213) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 22:56:27.081547) ========= 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.SOoRzULKaB/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.uYCEYb4Mv6/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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.026229 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 22:56:27.130510) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 22:56:27.130904) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 84c59d136a9e54be69571b75a19e8a8ccff7b8a1 --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 84c59d136a9e54be69571b75a19e8a8ccff7b8a1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SOoRzULKaB/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.uYCEYb4Mv6/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-13 22:56:27,214 truncating revision to first 12 chars 2016-07-13 22:56:27,214 Setting DEBUG logging. 2016-07-13 22:56:27,214 attempt 1/10 2016-07-13 22:56:27,214 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/84c59d136a9e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 22:56:28,183 unpacking tar archive at: mozilla-beta-84c59d136a9e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.241205 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 22:56:28.396945) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 22:56:28.397384) ========= script_repo_revision: 84c59d136a9e54be69571b75a19e8a8ccff7b8a1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 22:56:28.397861) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 22:56:28.398192) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 22:56:28.416715) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2016-07-13 22:56:28.417041) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SOoRzULKaB/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.uYCEYb4Mv6/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 22:56:28 INFO - MultiFileLogger online at 20160713 22:56:28 in /builds/slave/test 22:56:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 22:56:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:56:28 INFO - {'append_to_log': False, 22:56:28 INFO - 'base_work_dir': '/builds/slave/test', 22:56:28 INFO - 'blob_upload_branch': 'Mozilla-Beta', 22:56:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:56:28 INFO - 'branch': 'Mozilla-Beta', 22:56:28 INFO - 'buildbot_json_path': 'buildprops.json', 22:56:28 INFO - 'config_files': ('talos/mac_config.py',), 22:56:28 INFO - 'default_actions': ('clobber', 22:56:28 INFO - 'read-buildbot-config', 22:56:28 INFO - 'download-and-extract', 22:56:28 INFO - 'populate-webroot', 22:56:28 INFO - 'create-virtualenv', 22:56:28 INFO - 'install', 22:56:28 INFO - 'run-tests'), 22:56:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:56:28 INFO - 'download_minidump_stackwalk': True, 22:56:28 INFO - 'download_symbols': 'ondemand', 22:56:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:56:28 INFO - 'tooltool.py': '/tools/tooltool.py', 22:56:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:56:28 INFO - '/tools/misc-python/virtualenv.py')}, 22:56:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:56:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:56:28 INFO - 'installer_path': 'installer.exe', 22:56:28 INFO - 'log_level': 'info', 22:56:28 INFO - 'log_name': 'talos', 22:56:28 INFO - 'log_to_console': True, 22:56:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:56:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:56:28 INFO - 'opt_config_files': (), 22:56:28 INFO - 'pip_index': False, 22:56:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:56:28 INFO - 'cmd': ('bash', 22:56:28 INFO - '-c', 22:56:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:56:28 INFO - 'enabled': True, 22:56:28 INFO - 'halt_on_failure': False, 22:56:28 INFO - 'name': 'check_screen_resolution'},), 22:56:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:56:28 INFO - 'cmd': ('bash', 22:56:28 INFO - '-c', 22:56:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:56:28 INFO - 'enabled': True, 22:56:28 INFO - 'halt_on_failure': False, 22:56:28 INFO - 'name': 'check_screen_resolution'},), 22:56:28 INFO - 'run_cmd_checks_enabled': True, 22:56:28 INFO - 'sps_profile': False, 22:56:28 INFO - 'sps_profile_interval': 0, 22:56:28 INFO - 'suite': 'dromaeojs-e10s', 22:56:28 INFO - 'system_bits': '32', 22:56:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:56:28 INFO - 'title': 't-yosemite-r7-0326', 22:56:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:56:28 INFO - 'use_talos_json': True, 22:56:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:56:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:56:28 INFO - 'work_dir': 'build'} 22:56:28 INFO - ##### 22:56:28 INFO - ##### Running clobber step. 22:56:28 INFO - ##### 22:56:28 INFO - Running pre-action listener: _resource_record_pre_action 22:56:28 INFO - Running main action method: clobber 22:56:28 INFO - rmtree: /builds/slave/test/build 22:56:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:56:30 INFO - Running post-action listener: _resource_record_post_action 22:56:30 INFO - ##### 22:56:30 INFO - ##### Running read-buildbot-config step. 22:56:30 INFO - ##### 22:56:30 INFO - Running pre-action listener: _resource_record_pre_action 22:56:30 INFO - Running main action method: read_buildbot_config 22:56:30 INFO - Using buildbot properties: 22:56:30 INFO - { 22:56:30 INFO - "project": "", 22:56:30 INFO - "product": "firefox", 22:56:30 INFO - "script_repo_revision": "production", 22:56:30 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 22:56:30 INFO - "repository": "", 22:56:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 22:56:30 INFO - "buildid": "20160713154642", 22:56:30 INFO - "pgo_build": "False", 22:56:30 INFO - "basedir": "/builds/slave/test", 22:56:30 INFO - "buildnumber": 44, 22:56:30 INFO - "slavename": "t-yosemite-r7-0326", 22:56:30 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 22:56:30 INFO - "platform": "yosemite_r7", 22:56:30 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 22:56:30 INFO - "branch": "mozilla-beta", 22:56:30 INFO - "repo_path": "releases/mozilla-beta", 22:56:30 INFO - "revision": "84c59d136a9e54be69571b75a19e8a8ccff7b8a1", 22:56:30 INFO - "stage_platform": "macosx64", 22:56:30 INFO - "builduid": "0219f93640ac4a39933847396c8d0f21", 22:56:30 INFO - "slavebuilddir": "test" 22:56:30 INFO - } 22:56:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 22:56:30 INFO - Running post-action listener: _resource_record_post_action 22:56:30 INFO - ##### 22:56:30 INFO - ##### Running download-and-extract step. 22:56:30 INFO - ##### 22:56:30 INFO - Running pre-action listener: _resource_record_pre_action 22:56:30 INFO - Running main action method: download_and_extract 22:56:30 INFO - mkdir: /builds/slave/test/build/tests 22:56:30 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')]} 22:56:30 INFO - https://queue.taskcluster.net/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 22:56:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 22:56:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 22:56:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 22:56:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 22:56:40 INFO - Downloaded 1165 bytes. 22:56:40 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 22:56:40 INFO - Using the following test package requirements: 22:56:40 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 22:56:40 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 22:56:40 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 22:56:40 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 22:56:40 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 22:56:40 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 22:56:40 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 22:56:40 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 22:56:40 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 22:56:40 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 22:56:40 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 22:56:40 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 22:56:40 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 22:56:40 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 22:56:40 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 22:56:40 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 22:56:40 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 22:56:40 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 22:56:40 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')]} 22:56:40 INFO - https://queue.taskcluster.net/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:56:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 22:56:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 22:56:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 22:56:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 22:57:06 INFO - Downloaded 18314911 bytes. 22:57:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:57:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 22:57:09 INFO - Return code: 0 22:57:09 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 22:57:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:09 INFO - https://queue.taskcluster.net/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:57:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 22:57:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 22:57:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 22:57:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 22:57:19 INFO - Downloaded 18314911 bytes. 22:57:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:57:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 22:57:22 INFO - Return code: 0 22:57:22 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')]} 22:57:22 INFO - https://queue.taskcluster.net/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 22:57:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 22:57:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 22:57:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 22:57:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 22:57:23 INFO - Downloaded 10840145 bytes. 22:57:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:57:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 22:57:23 INFO - Return code: 0 22:57:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:23 INFO - https://queue.taskcluster.net/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 22:57:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 22:57:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 22:57:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 22:57:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 22:57:26 INFO - Downloaded 86190055 bytes. 22:57:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 22:57:26 INFO - mkdir: /builds/slave/test/properties 22:57:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:57:26 INFO - Writing to file /builds/slave/test/properties/build_url 22:57:26 INFO - Contents: 22:57:26 INFO - build_url:https://queue.taskcluster.net/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 22:57:27 INFO - Running post-action listener: _resource_record_post_action 22:57:27 INFO - Running post-action listener: set_extra_try_arguments 22:57:27 INFO - ##### 22:57:27 INFO - ##### Running populate-webroot step. 22:57:27 INFO - ##### 22:57:27 INFO - Running pre-action listener: _resource_record_pre_action 22:57:27 INFO - Running main action method: populate_webroot 22:57:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:57:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:57:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:57:27 INFO - '--tppagecycles', 22:57:27 INFO - '7'], 22:57:27 INFO - 'tests': ['tsvgm']}}, 22:57:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:57:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:57:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:57:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:57:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:57:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:57:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:27 INFO - 'talos_options': ['--disable-e10s'], 22:57:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:57:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:57:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:27 INFO - 'talos_options': ['--disable-e10s'], 22:57:27 INFO - 'tests': ['damp', 'tps']}, 22:57:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:27 INFO - 'tests': ['damp', 'tps']}, 22:57:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:57:27 INFO - 'tests': ['dromaeo_dom']}, 22:57:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:57:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:57:27 INFO - 'tests': ['a11yr', 22:57:27 INFO - 'ts_paint', 22:57:27 INFO - 'tpaint', 22:57:27 INFO - 'sessionrestore', 22:57:27 INFO - 'sessionrestore_no_auto_restore', 22:57:27 INFO - 'tabpaint']}, 22:57:27 INFO - 'other-e10s': {'tests': ['a11yr', 22:57:27 INFO - 'ts_paint', 22:57:27 INFO - 'tpaint', 22:57:27 INFO - 'sessionrestore', 22:57:27 INFO - 'sessionrestore_no_auto_restore', 22:57:27 INFO - 'tabpaint']}, 22:57:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:57:27 INFO - 'ts_paint', 22:57:27 INFO - 'tpaint', 22:57:27 INFO - 'sessionrestore', 22:57:27 INFO - 'sessionrestore_no_auto_restore', 22:57:27 INFO - 'tabpaint']}, 22:57:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:57:27 INFO - 'ts_paint', 22:57:27 INFO - 'tpaint', 22:57:27 INFO - 'sessionrestore', 22:57:27 INFO - 'sessionrestore_no_auto_restore', 22:57:27 INFO - 'tabpaint']}, 22:57:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:57:27 INFO - 'tests': ['a11yr', 22:57:27 INFO - 'ts_paint', 22:57:27 INFO - 'tpaint', 22:57:27 INFO - 'sessionrestore', 22:57:27 INFO - 'sessionrestore_no_auto_restore', 22:57:27 INFO - 'tabpaint']}, 22:57:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:57:27 INFO - 'tests': ['a11yr', 22:57:27 INFO - 'ts_paint', 22:57:27 INFO - 'tpaint', 22:57:27 INFO - 'sessionrestore', 22:57:27 INFO - 'sessionrestore_no_auto_restore', 22:57:27 INFO - 'tabpaint']}, 22:57:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:57:27 INFO - 'tests': ['tsvgx', 22:57:27 INFO - 'tsvgr_opacity', 22:57:27 INFO - 'tart', 22:57:27 INFO - 'tscrollx', 22:57:27 INFO - 'cart']}, 22:57:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:57:27 INFO - 'tsvgr_opacity', 22:57:27 INFO - 'tart', 22:57:27 INFO - 'tscrollx', 22:57:27 INFO - 'cart']}, 22:57:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:27 INFO - 'talos_options': ['--disable-e10s'], 22:57:27 INFO - 'tests': ['tp5o']}, 22:57:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:27 INFO - 'tests': ['tp5o']}, 22:57:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:27 INFO - 'talos_options': ['--disable-e10s', 22:57:27 INFO - '--xperf_path', 22:57:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:57:27 INFO - 'tests': ['tp5n']}, 22:57:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:27 INFO - 'talos_options': ['--xperf_path', 22:57:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:57:27 INFO - 'tests': ['tp5n']}}, 22:57:27 INFO - 'talos.zip': {'path': '', 22:57:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:57:27 INFO - Running post-action listener: _resource_record_post_action 22:57:27 INFO - ##### 22:57:27 INFO - ##### Running create-virtualenv step. 22:57:27 INFO - ##### 22:57:27 INFO - Running pre-action listener: _resource_record_pre_action 22:57:27 INFO - Running main action method: create_virtualenv 22:57:27 INFO - Creating virtualenv /builds/slave/test/build/venv 22:57:27 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 22:57:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:57:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:57:27 INFO - Using real prefix '/tools/python27' 22:57:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:57:28 INFO - Installing distribute.............................................................................................................................................................................................done. 22:57:31 INFO - Installing pip.................done. 22:57:31 INFO - Return code: 0 22:57:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:31 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 0x10f3a8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3b8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a3c8ae30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f247e00>, '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 0x10f0b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f242b20>, '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.SOoRzULKaB/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.uYCEYb4Mv6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 22:57:31 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 22:57:31 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 22:57:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SOoRzULKaB/Render', 22:57:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:31 INFO - 'HOME': '/Users/cltbld', 22:57:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:31 INFO - 'LOGNAME': 'cltbld', 22:57:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:31 INFO - 'MOZ_NO_REMOTE': '1', 22:57:31 INFO - 'NO_EM_RESTART': '1', 22:57:31 INFO - 'PAGER': '/bin/cat', 22:57:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:31 INFO - 'PWD': '/builds/slave/test', 22:57:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:31 INFO - 'SHELL': '/bin/bash', 22:57:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uYCEYb4Mv6/Listeners', 22:57:31 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 22:57:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:31 INFO - 'USER': 'cltbld', 22:57:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:31 INFO - 'XPC_FLAGS': '0x0', 22:57:31 INFO - 'XPC_SERVICE_NAME': '0', 22:57:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:57:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:31 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 22:57:31 INFO - Cleaning up... 22:57:31 INFO - Return code: 0 22:57:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:31 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 0x10f3a8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3b8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a3c8ae30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f247e00>, '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 0x10f0b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f242b20>, '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.SOoRzULKaB/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.uYCEYb4Mv6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 22:57:31 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 22:57:31 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 22:57:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SOoRzULKaB/Render', 22:57:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:31 INFO - 'HOME': '/Users/cltbld', 22:57:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:31 INFO - 'LOGNAME': 'cltbld', 22:57:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:31 INFO - 'MOZ_NO_REMOTE': '1', 22:57:31 INFO - 'NO_EM_RESTART': '1', 22:57:31 INFO - 'PAGER': '/bin/cat', 22:57:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:31 INFO - 'PWD': '/builds/slave/test', 22:57:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:31 INFO - 'SHELL': '/bin/bash', 22:57:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uYCEYb4Mv6/Listeners', 22:57:31 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 22:57:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:31 INFO - 'USER': 'cltbld', 22:57:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:31 INFO - 'XPC_FLAGS': '0x0', 22:57:31 INFO - 'XPC_SERVICE_NAME': '0', 22:57:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:57:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:31 INFO - Downloading/unpacking psutil>=0.7.1 22:57: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 22:57: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 22:57: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 22:57: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 22:57: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 22:57: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 22:57:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:57:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:57:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:57:35 INFO - Installing collected packages: psutil 22:57:35 INFO - Running setup.py install for psutil 22:57:35 INFO - building 'psutil._psutil_osx' extension 22:57:35 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 22:57:35 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 22:57:35 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 22:57:35 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 22:57:35 INFO - building 'psutil._psutil_posix' extension 22:57:35 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 22:57:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:57:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:57:35 INFO - ^ 22:57:36 INFO - 1 warning generated. 22:57:36 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 22:57:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:57:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:57:36 INFO - Successfully installed psutil 22:57:36 INFO - Cleaning up... 22:57:36 INFO - Return code: 0 22:57:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:57:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f3a8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3b8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a3c8ae30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f247e00>, '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 0x10f0b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f242b20>, '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.SOoRzULKaB/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.uYCEYb4Mv6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 22:57:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:57:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:57:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SOoRzULKaB/Render', 22:57:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:36 INFO - 'HOME': '/Users/cltbld', 22:57:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:36 INFO - 'LOGNAME': 'cltbld', 22:57:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:36 INFO - 'MOZ_NO_REMOTE': '1', 22:57:36 INFO - 'NO_EM_RESTART': '1', 22:57:36 INFO - 'PAGER': '/bin/cat', 22:57:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:36 INFO - 'PWD': '/builds/slave/test', 22:57:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:36 INFO - 'SHELL': '/bin/bash', 22:57:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uYCEYb4Mv6/Listeners', 22:57:36 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 22:57:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:36 INFO - 'USER': 'cltbld', 22:57:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:36 INFO - 'XPC_FLAGS': '0x0', 22:57:36 INFO - 'XPC_SERVICE_NAME': '0', 22:57:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:57:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:57:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:57:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:57:39 INFO - Installing collected packages: mozsystemmonitor 22:57:39 INFO - Running setup.py install for mozsystemmonitor 22:57:39 INFO - Successfully installed mozsystemmonitor 22:57:39 INFO - Cleaning up... 22:57:39 INFO - Return code: 0 22:57:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:39 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 0x10f3a8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3b8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a3c8ae30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f247e00>, '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 0x10f0b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f242b20>, '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.SOoRzULKaB/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.uYCEYb4Mv6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 22:57:39 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 22:57:39 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 22:57:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SOoRzULKaB/Render', 22:57:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:39 INFO - 'HOME': '/Users/cltbld', 22:57:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:39 INFO - 'LOGNAME': 'cltbld', 22:57:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:39 INFO - 'MOZ_NO_REMOTE': '1', 22:57:39 INFO - 'NO_EM_RESTART': '1', 22:57:39 INFO - 'PAGER': '/bin/cat', 22:57:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:39 INFO - 'PWD': '/builds/slave/test', 22:57:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:39 INFO - 'SHELL': '/bin/bash', 22:57:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uYCEYb4Mv6/Listeners', 22:57:39 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 22:57:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:39 INFO - 'USER': 'cltbld', 22:57:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:39 INFO - 'XPC_FLAGS': '0x0', 22:57:39 INFO - 'XPC_SERVICE_NAME': '0', 22:57:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:57:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:39 INFO - Downloading/unpacking blobuploader==1.2.4 22:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:41 INFO - Downloading blobuploader-1.2.4.tar.gz 22:57:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:57:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:57: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 22:57: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 22:57: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 22:57: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 22:57: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 22:57: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 22:57:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:57:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:57: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 22:57: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 22:57: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 22:57: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 22:57: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 22:57: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 22:57:43 INFO - Downloading docopt-0.6.1.tar.gz 22:57:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:57:43 INFO - Installing collected packages: blobuploader, requests, docopt 22:57:43 INFO - Running setup.py install for blobuploader 22:57:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:57:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:57:43 INFO - Running setup.py install for requests 22:57:43 INFO - Running setup.py install for docopt 22:57:44 INFO - Successfully installed blobuploader requests docopt 22:57:44 INFO - Cleaning up... 22:57:44 INFO - Return code: 0 22:57:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:44 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 0x10f3a8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3b8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a3c8ae30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f247e00>, '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 0x10f0b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f242b20>, '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.SOoRzULKaB/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.uYCEYb4Mv6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 22:57:44 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 22:57:44 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 22:57:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SOoRzULKaB/Render', 22:57:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:44 INFO - 'HOME': '/Users/cltbld', 22:57:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:44 INFO - 'LOGNAME': 'cltbld', 22:57:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:44 INFO - 'MOZ_NO_REMOTE': '1', 22:57:44 INFO - 'NO_EM_RESTART': '1', 22:57:44 INFO - 'PAGER': '/bin/cat', 22:57:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:44 INFO - 'PWD': '/builds/slave/test', 22:57:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:44 INFO - 'SHELL': '/bin/bash', 22:57:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uYCEYb4Mv6/Listeners', 22:57:44 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 22:57:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:44 INFO - 'USER': 'cltbld', 22:57:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:44 INFO - 'XPC_FLAGS': '0x0', 22:57:44 INFO - 'XPC_SERVICE_NAME': '0', 22:57:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:57:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:57:44 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-kyqWpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:57:44 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-KQWGYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:57:44 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-5hltRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:57:44 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-zvuBVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:57:44 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-eypqKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:57:44 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-mHoX04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:57:45 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-j5zC2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:57:45 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-y_X8iZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:57:45 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-dmWrXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:57:45 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-Gysqrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:57:45 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-9GxiI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:57:45 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-FB1sE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:57:45 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-f3NICg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:57:45 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-2TtdLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:57:45 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-NKcC4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:57:46 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-m2iuHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:57:46 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-yNZSoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:57:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:57:46 INFO - Running setup.py install for manifestparser 22:57:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:57:46 INFO - Running setup.py install for mozcrash 22:57:46 INFO - Running setup.py install for mozdebug 22:57:46 INFO - Running setup.py install for mozdevice 22:57:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:57:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:57:46 INFO - Running setup.py install for mozfile 22:57:46 INFO - Running setup.py install for mozhttpd 22:57:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:57:47 INFO - Running setup.py install for mozinfo 22:57:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:57:47 INFO - Running setup.py install for mozInstall 22:57:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:57:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:57:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:57:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:57:47 INFO - Running setup.py install for mozleak 22:57:47 INFO - Running setup.py install for mozlog 22:57:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:57:47 INFO - Running setup.py install for moznetwork 22:57:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:57:47 INFO - Running setup.py install for mozprocess 22:57:48 INFO - Running setup.py install for mozprofile 22:57:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:57:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:57:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:57:48 INFO - Running setup.py install for mozrunner 22:57:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:57:48 INFO - Running setup.py install for mozscreenshot 22:57:48 INFO - Running setup.py install for moztest 22:57:48 INFO - Running setup.py install for mozversion 22:57:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:57:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:57:48 INFO - Cleaning up... 22:57:48 INFO - Return code: 0 22:57:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:48 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 0x10f3a8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3b8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a3c8ae30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f247e00>, '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 0x10f0b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f242b20>, '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.SOoRzULKaB/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.uYCEYb4Mv6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 22:57:48 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 22:57:48 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 22:57:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SOoRzULKaB/Render', 22:57:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:48 INFO - 'HOME': '/Users/cltbld', 22:57:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:48 INFO - 'LOGNAME': 'cltbld', 22:57:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:48 INFO - 'MOZ_NO_REMOTE': '1', 22:57:48 INFO - 'NO_EM_RESTART': '1', 22:57:48 INFO - 'PAGER': '/bin/cat', 22:57:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:48 INFO - 'PWD': '/builds/slave/test', 22:57:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:48 INFO - 'SHELL': '/bin/bash', 22:57:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uYCEYb4Mv6/Listeners', 22:57:48 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 22:57:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:48 INFO - 'USER': 'cltbld', 22:57:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:48 INFO - 'XPC_FLAGS': '0x0', 22:57:48 INFO - 'XPC_SERVICE_NAME': '0', 22:57:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:57:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:57:49 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-aWfjA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:57:49 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)) 22:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:57:49 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-g5_uf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:57:49 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)) 22:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:57:49 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-5YpxdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:57:49 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)) 22:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:57:49 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-FYUiT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:57:49 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)) 22:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:57:49 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-qRM9cU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:57:49 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)) 22:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:57:49 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-i07M0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:57:49 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)) 22:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:57:49 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-A0jMNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:57:49 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)) 22:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:57:49 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-p0EEZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:57:49 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)) 22:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:57:49 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-igNUOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:57:50 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)) 22:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:57:50 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-JARbVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:57:50 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)) 22:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:57:50 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-OYEoLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:57:50 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)) 22:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:57:50 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-eO_xqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:57:50 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)) 22:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:57:50 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-twi1RJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:57:50 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)) 22:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:57:50 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-aXh3R2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:57:50 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)) 22:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:57:50 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-rfo8um-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:57:50 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)) 22:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:57:50 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-mkR2i4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:57:50 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)) 22:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:57:50 INFO - Running setup.py (path:/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/pip-KLn_nK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:57:50 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)) 22:57:50 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)) 22:57:50 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)) 22:57:50 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)) 22:57:50 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)) 22:57:50 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)) 22:57:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:57:50 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 22:57:50 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 22:57:50 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 22:57:50 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 22:57:50 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 22:57:50 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 22:57:53 INFO - Downloading blessings-1.6.tar.gz 22:57:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:57:53 INFO - Installing collected packages: blessings 22:57:53 INFO - Running setup.py install for blessings 22:57:53 INFO - Successfully installed blessings 22:57:53 INFO - Cleaning up... 22:57:53 INFO - Return code: 0 22:57:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:57:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:57:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:57:54 INFO - Reading from file tmpfile_stdout 22:57:54 INFO - Current package versions: 22:57:54 INFO - blessings == 1.6 22:57:54 INFO - blobuploader == 1.2.4 22:57:54 INFO - docopt == 0.6.1 22:57:54 INFO - manifestparser == 1.1 22:57:54 INFO - mozInstall == 1.12 22:57:54 INFO - mozcrash == 0.17 22:57:54 INFO - mozdebug == 0.1 22:57:54 INFO - mozdevice == 0.48 22:57:54 INFO - mozfile == 1.2 22:57:54 INFO - mozhttpd == 0.7 22:57:54 INFO - mozinfo == 0.9 22:57:54 INFO - mozleak == 0.1 22:57:54 INFO - mozlog == 3.1 22:57:54 INFO - moznetwork == 0.27 22:57:54 INFO - mozprocess == 0.22 22:57:54 INFO - mozprofile == 0.28 22:57:54 INFO - mozrunner == 6.11 22:57:54 INFO - mozscreenshot == 0.1 22:57:54 INFO - mozsystemmonitor == 0.0 22:57:54 INFO - moztest == 0.7 22:57:54 INFO - mozversion == 1.4 22:57:54 INFO - psutil == 3.1.1 22:57:54 INFO - requests == 1.2.3 22:57:54 INFO - wsgiref == 0.1.2 22:57:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:54 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 0x10f3a8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3b8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a3c8ae30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f247e00>, '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 0x10f0b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f242b20>, '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.SOoRzULKaB/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.uYCEYb4Mv6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 22:57:54 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 22:57:54 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 22:57:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SOoRzULKaB/Render', 22:57:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:54 INFO - 'HOME': '/Users/cltbld', 22:57:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:54 INFO - 'LOGNAME': 'cltbld', 22:57:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:54 INFO - 'MOZ_NO_REMOTE': '1', 22:57:54 INFO - 'NO_EM_RESTART': '1', 22:57:54 INFO - 'PAGER': '/bin/cat', 22:57:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:54 INFO - 'PWD': '/builds/slave/test', 22:57:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:54 INFO - 'SHELL': '/bin/bash', 22:57:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uYCEYb4Mv6/Listeners', 22:57:54 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 22:57:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:54 INFO - 'USER': 'cltbld', 22:57:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:54 INFO - 'XPC_FLAGS': '0x0', 22:57:54 INFO - 'XPC_SERVICE_NAME': '0', 22:57:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:57:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:54 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)) 22:57:54 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)) 22:57:54 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)) 22:57:54 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)) 22:57:54 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)) 22:57:54 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)) 22:57:54 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)) 22:57:54 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)) 22:57:54 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)) 22:57:54 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)) 22:57:54 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)) 22:57:54 INFO - Cleaning up... 22:57:54 INFO - Return code: 0 22:57:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3b8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a3c8ae30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f247e00>, '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 0x10f0b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f242b20>, '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.SOoRzULKaB/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.uYCEYb4Mv6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 22:57:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:57:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:57:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SOoRzULKaB/Render', 22:57:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:54 INFO - 'HOME': '/Users/cltbld', 22:57:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:54 INFO - 'LOGNAME': 'cltbld', 22:57:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:54 INFO - 'MOZ_NO_REMOTE': '1', 22:57:54 INFO - 'NO_EM_RESTART': '1', 22:57:54 INFO - 'PAGER': '/bin/cat', 22:57:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:54 INFO - 'PWD': '/builds/slave/test', 22:57:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:54 INFO - 'SHELL': '/bin/bash', 22:57:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uYCEYb4Mv6/Listeners', 22:57:54 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 22:57:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:54 INFO - 'USER': 'cltbld', 22:57:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:54 INFO - 'XPC_FLAGS': '0x0', 22:57:54 INFO - 'XPC_SERVICE_NAME': '0', 22:57:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:57:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:54 INFO - Downloading/unpacking jsonschema 22:57:54 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 22:57:54 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 22:57:54 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 22:57:54 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 22:57:54 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 22:57:54 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 22:57:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:57:57 INFO - Downloading/unpacking functools32 (from jsonschema) 22:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:57 INFO - Downloading functools32-3.2.3-2.tar.gz 22:57:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:57:57 INFO - warning: no files found matching '*.txt' 22:57:57 INFO - no previously-included directories found matching 'build' 22:57:57 INFO - no previously-included directories found matching 'dist' 22:57:57 INFO - no previously-included directories found matching '.git*' 22:57:57 INFO - Installing collected packages: jsonschema, functools32 22:57:57 INFO - Running setup.py install for functools32 22:57:57 INFO - warning: no files found matching '*.txt' 22:57:57 INFO - no previously-included directories found matching 'build' 22:57:57 INFO - no previously-included directories found matching 'dist' 22:57:57 INFO - no previously-included directories found matching '.git*' 22:57:57 INFO - Successfully installed jsonschema functools32 22:57:57 INFO - Cleaning up... 22:57:57 INFO - Return code: 0 22:57:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3b8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5a3c8ae30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f247e00>, '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 0x10f0b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f242b20>, '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.SOoRzULKaB/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.uYCEYb4Mv6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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 22:57:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:57:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SOoRzULKaB/Render', 22:57:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:57:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:57:57 INFO - 'HOME': '/Users/cltbld', 22:57:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:57:57 INFO - 'LOGNAME': 'cltbld', 22:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:57 INFO - 'MOZ_NO_REMOTE': '1', 22:57:57 INFO - 'NO_EM_RESTART': '1', 22:57:57 INFO - 'PAGER': '/bin/cat', 22:57:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:57:57 INFO - 'PWD': '/builds/slave/test', 22:57:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:57:57 INFO - 'SHELL': '/bin/bash', 22:57:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uYCEYb4Mv6/Listeners', 22:57:57 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 22:57:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:57:57 INFO - 'USER': 'cltbld', 22:57:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:57:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:57 INFO - 'XPC_FLAGS': '0x0', 22:57:57 INFO - 'XPC_SERVICE_NAME': '0', 22:57:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:57:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:58 INFO - Downloading/unpacking flake8 22:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:58:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:58:00 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 22:58:00 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 22:58:00 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 22:58:00 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 22:58:00 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 22:58:00 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 22:58:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:58:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:58:00 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 22:58:00 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 22:58:00 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 22:58:00 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 22:58:00 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 22:58:00 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 22:58:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:58:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:58:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:58:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:58:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:58:01 INFO - no previously-included directories found matching 'docs/_build' 22:58:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:58:02 INFO - Running setup.py install for pep8 22:58:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:58:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:58:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:58:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:58:02 INFO - no previously-included directories found matching 'docs/_build' 22:58:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:58:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:58:02 INFO - Cleaning up... 22:58:02 INFO - Return code: 0 22:58:02 INFO - Running post-action listener: _resource_record_post_action 22:58:02 INFO - Running post-action listener: _start_resource_monitoring 22:58:02 INFO - Starting resource monitoring. 22:58:02 INFO - ##### 22:58:02 INFO - ##### Running install step. 22:58:02 INFO - ##### 22:58:02 INFO - Running pre-action listener: _resource_record_pre_action 22:58:02 INFO - Running main action method: install 22:58:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:58:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:58:02 INFO - Reading from file tmpfile_stdout 22:58:02 INFO - Detecting whether we're running mozinstall >=1.0... 22:58:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:58:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:58:02 INFO - Reading from file tmpfile_stdout 22:58:02 INFO - Output received: 22:58:02 INFO - Usage: mozinstall [options] installer 22:58:02 INFO - Options: 22:58:02 INFO - -h, --help show this help message and exit 22:58:02 INFO - -d DEST, --destination=DEST 22:58:02 INFO - Directory to install application into. [default: 22:58:02 INFO - "/builds/slave/test"] 22:58:02 INFO - --app=APP Application being installed. [default: firefox] 22:58:02 INFO - mkdir: /builds/slave/test/build/application 22:58:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 22:58:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 22:58:24 INFO - Reading from file tmpfile_stdout 22:58:24 INFO - Output received: 22:58:24 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 22:58:24 INFO - Running post-action listener: _resource_record_post_action 22:58:24 INFO - ##### 22:58:24 INFO - ##### Running run-tests step. 22:58:24 INFO - ##### 22:58:24 INFO - Running pre-action listener: _resource_record_pre_action 22:58:24 INFO - Running main action method: run_tests 22:58:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:58:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:58:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:58:24 INFO - 2016-07-13 22:58:24.571 screenresolution[1647:9150] starting screenresolution argv=screenresolution get 22:58:24 INFO - 2016-07-13 22:58:24.574 screenresolution[1647:9150] Display 0: 1600x1200x32@60 22:58:24 INFO - 2016-07-13 22:58:24.579 screenresolution[1648:9152] starting screenresolution argv=screenresolution list 22:58:24 INFO - Available Modes on Display 0 22:58:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:58:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:58:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:58:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:58:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:58:24 INFO - Intel Iris: 22:58:24 INFO - Chipset Model: Intel Iris 22:58:24 INFO - Type: GPU 22:58:24 INFO - Bus: Built-In 22:58:24 INFO - VRAM (Dynamic, Max): 1536 MB 22:58:24 INFO - Vendor: Intel (0x8086) 22:58:24 INFO - Device ID: 0x0a2e 22:58:24 INFO - Revision ID: 0x0009 22:58:24 INFO - Displays: 22:58:24 INFO - Display: 22:58:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:58:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:58:24 INFO - Display Serial Number: 1600x1200 60 22:58:24 INFO - Main Display: Yes 22:58:24 INFO - Mirror: Off 22:58:24 INFO - Online: Yes 22:58:24 INFO - Rotation: Supported 22:58:24 INFO - Return code: 0 22:58:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:58:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:58:24 INFO - Python 2.7.3 22:58:24 INFO - Return code: 0 22:58:24 INFO - grabbing minidump binary from tooltool 22:58: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')]} 22:58:24 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 0x10f247e00>, '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 0x10f0b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f242b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:58:24 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 22:58:24 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 22:58:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:58:24 INFO - Return code: 0 22:58:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:58:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:58:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:58:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:58:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:58:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:58:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:58:25 INFO - Return code: 0 22:58:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0326', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0326 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:58:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SOoRzULKaB/Render', 22:58:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:58:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:58:25 INFO - 'HOME': '/Users/cltbld', 22:58:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:58:25 INFO - 'LOGNAME': 'cltbld', 22:58:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:58:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:58:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:26 INFO - 'MOZ_NO_REMOTE': '1', 22:58:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:58:26 INFO - 'NO_EM_RESTART': '1', 22:58:26 INFO - 'PAGER': '/bin/cat', 22:58:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:58:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:58:26 INFO - 'PWD': '/builds/slave/test', 22:58:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:58:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:58:26 INFO - 'SHELL': '/bin/bash', 22:58:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uYCEYb4Mv6/Listeners', 22:58:26 INFO - 'TMPDIR': '/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/', 22:58:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:58:26 INFO - 'USER': 'cltbld', 22:58:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:58:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:58:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:26 INFO - 'XPC_FLAGS': '0x0', 22:58:26 INFO - 'XPC_SERVICE_NAME': '0', 22:58:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:58:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0326', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:58:26 INFO - mozversion application_buildid: 20160713154642 22:58:26 INFO - mozversion application_changeset: 84c59d136a9e54be69571b75a19e8a8ccff7b8a1 22:58:26 INFO - mozversion application_display_name: Firefox 22:58:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:58:26 INFO - mozversion application_name: Firefox 22:58:26 INFO - mozversion application_remotingname: firefox 22:58:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 22:58:26 INFO - mozversion application_vendor: Mozilla 22:58:26 INFO - mozversion application_version: 48.0 22:58:26 INFO - mozversion platform_buildid: 20160713154642 22:58:26 INFO - mozversion platform_changeset: 84c59d136a9e54be69571b75a19e8a8ccff7b8a1 22:58:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 22:58:26 INFO - mozversion platform_version: 48.0 22:58:26 INFO - using testdate: 1468475906 22:58:26 INFO - actual date: 1468475906 22:58:26 INFO - starting webserver on 'localhost:49275' 22:58:26 INFO - SUITE-START | Running 2 tests 22:58:26 INFO - TEST-START | dromaeo_css 22:58:26 INFO - operating with platform_type : mac_ 22:58:26 INFO - Initialising browser for dromaeo_css test... 22:58:26 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmpsYuKUX/profile http://localhost:49275/getInfo.html) 22:58:29 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 22:58:29 INFO - PROCESS | 1666 | colorDepth:24 22:58:29 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 22:58:29 INFO - PROCESS | 1666 | __metrics 22:58:29 ERROR - PROCESS | 1666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 22:58:29 INFO - TEST-INFO | 1666: exit 0 22:58:29 INFO - Browser initialized. 22:58:29 INFO - Running cycle 1/1 for dromaeo_css test... 22:58:29 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmpsYuKUX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:58:41 INFO - PROCESS | 1671 | RSS: Main: 171085824 22:58:41 INFO - PROCESS | 1671 | 22:59:31 INFO - PROCESS | 1671 | 1468475971412 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] 23:01:41 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 23:01:43 INFO - PROCESS | 1671 | RSS: Main: 181948416 23:01:43 INFO - PROCESS | 1671 | 23:04:45 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 23:04:45 INFO - PROCESS | 1671 | RSS: Main: 192548864 23:04:45 INFO - PROCESS | 1671 | 23:07:47 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 23:07:48 INFO - PROCESS | 1671 | RSS: Main: 194543616 23:07:48 INFO - PROCESS | 1671 | 23:10:49 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 23:10:50 INFO - PROCESS | 1671 | RSS: Main: 198246400 23:10:50 INFO - PROCESS | 1671 | 23:13:53 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 23:13:53 INFO - PROCESS | 1671 | RSS: Main: 197754880 23:13:53 INFO - PROCESS | 1671 | 23:16:55 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 23:16:56 INFO - PROCESS | 1671 | RSS: Main: 202956800 23:16:56 INFO - PROCESS | 1671 | 23:16:56 INFO - PROCESS | 1671 | __start_tp_report 23:16:56 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 23:16:56 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 23:16:56 INFO - PROCESS | 1671 | |i|pagename|runs| 23:16:56 INFO - PROCESS | 1671 | |0;dojo.html;3578.928421431571;3654.6162652921444;3656.2687462507506;3688.4836122942793;3705.759125656832;5880.088586269129;5894.793682221123;5921.786033863059;5943.3165186003625;5991.460768530831;5913.408659134085;5929.614575052618;5934.9317122917855;5962;5974.133750606159;5368.221607866857;5373.704446255454;5394.217838413428;5415.025295446818;5507.311586051744;5352.2239275305055;5435.945640543583;5450.100733379008;5454.781808727646;5475.589330800206;5418.539424148932;5419.756110975016;5434.565234781227;5442.047641662713;5473.261109750192;5398.8920221595745;5445.564354851603;5447.700376479292;5459.727013649322;5472.069748142825;5231.529162375405;5309.840704778863;5405.8107966221;5441.782328706847;5443.891122177574;5658.943410565924;5719.971400143014;5814.97092514539;5818.970905145447;5937.821865344046;6205.596636218676;6280.685965701697;6281.152044473984;6282.78010269643;6287.308396076428;6283.968580157116;6337.176167098294;6341.714622841983;6350;6416.197975253093;5418.891622167614;5825.242718446617;5983.790567330209;6093.421124993119;6098.2682078150465;6440.645764482904;6521.8695626088165;6528.020796880506;6540.509461790385;6567.540272180901;6244.375562443719;6252.531060170505;6258.655773932477;6259.78090766821;6271.623702577769;5349.545288650431;6044.909326360108;6110.7861224856915;6314.336994615591;6367.713452894631;6261.405166509175;6274.372562743689;6291.370862913764;6295.464885484785;6319.620822750558;6237.09562113491;6265.530085243625;6292.276388215322;6293.213348331458;6299.244090709144;4991.176455884811;5000.549950504472;5005.499450055038;5074.695518268915;5108.693478391308;4513.142502924434;4554.795034223468;4559.697352836796;4574.08518296342;4599.425071866017;6102.420270074336;6154.323024467305;6159.938400615936;6165.445109940127;6169.907451388232;5428.945710542923;6224.875502489925;6247.875042499125;6294;6322.430981211621;6118.131909153847;6139.605553834008;6140.416660417253;6144.972159187458;6160.168377269011;5635.6618602883955;5636.718164091779;5646.717664116778;5649.68926709035;5669.914951275734;5132.589392848563;6085.90453718335;6331.841703957438;6609.900851487231;6625.469962403093;6336.841578960563;6361.522885783677;6367.61794292344;6410.134631824831;6417.935820641734;5583.413741557078;6642.667866606554;6654.667266636552;6681.164854393201;6685.799426017227;6185.8144255672405;6282.685865706788;6294.842628934313;6298.905516417166;6306.400891915261;6323.778667746791;6362;6367.777127800505;6376.904346434714;6407.231132264158;5606.906653202586;6177.980633195472;6254.749810007731;6264.874702505833;6266.154069200599;6167.753289868355;6182.350853160354;6228.314885362516;6240.906386404116;6256.374362563707;5718.828435146952;6186.938130618636;6209.906851397142;6215.564910456224;6219.315875253628;5289.7355132242465;6124.081387791867;6218.19163508741;6229.719662615284;6252.937470625236;5251.396089449762;6198.0702894566175;6201.844953876189;6213.627182369072;6217.09852071438 23:16:56 INFO - PROCESS | 1671 | |1;ext.html;537.521605770864;548.3133011365697;555.8443635781982;615.2770494668763;629.8016124920653;33021.66978330216;39745.403818942665;39847.402288965655;39864.20271594566;39914.20171596566;33853.49219761699;41498.37752433716;41948.79025604876;41950.790246048804;42079;9735.46454944976;9896.95051524745;9910.653127140551;9914.752131196705;9920.950395248014;9662.32363734539;9777.755556111118;9790.412575245473;9809.264305177141;9900.603975840957;9735.36720113194;9805.362651427635;9823.361481503714;9829.459379734111;9981.850272245922;9826.754331141707;9876.950615246878;9889.06053924876;9908.702738917844;9921.652742154027;9843.310968232227;9958.651447199314;9976;9976.750581235454;9998.400095994264;41562.75311740653;41751.58248417507;41969.79015104905;42004.159916801495;42038.528651497356;3342.7660063795543;3369.6124945631323;3467.4625433057918;3772.490713753663;3830.444585535082;28287.009954651487;29159;29478.70521294781;29651.55522667162;29876;2809.7330753578376;2824.844633545154;2828.278788908815;2863.599096126544;2898.840563769013;469853;474917;475521.62239188584;475713;477332;60762.39237607656;61699.691501542206;62157.689211553654;62342;62518.374816252166;57797.71101144551;58015;60435.39564604386;64278.67860660667;66500;16955.745663815054;17804.46586602404;18024.918504889487;18080.643951703674;18096.00471974054;14034.578962631138;14040.508582199778;14100.647483812782;14136.222507761966;14152.150870947777;16153.596160095856;16179.433719819985;16199.67600648004;16230.837691622932;16266.18669066542;6313.842153946096;6797.864042719118;7042.330978557029;7361.447891408059;7433.8141546461775;1019.4851599941982;1030.5377714496212;1085.9954542048574;1132.881511573363;1163.4299193395345;30136;30747.846260769;30758.692413075583;30812;30819.845900770353;1116.944152792357;1169.6958790714305;1195.1813008089487;1224.6693392784077;1246.3954981833804;14349.56951291463;14419.78370324446;14494.710105797825;14729.779053314209;14856.702865942621;610730;620454;620668;629692.8515357394;629763;58808;59869.70065149647;60249.69875150596;60546.69726651427;60570.69714651487;1388.7291978064181;1549.1711934115194;1564.8591626753646;1572.7404978178702;1576.408846682494;28125;28337.29156771097;29028;29113.126606201848;29148.562771558867;49386.76533086701;52306.738466307426;52968.73515632397;53024;53111.73444132755;435958;465874;467402;467613;469659;25504.489910202064;27202.31994200161;28295.29261768472;28326;28453;43032.78483607562;43757.68726938197;44545.88635284144;44706;45401.772991134836;30532;34204.48693269653;36279.45580816237;36391;36934.8153259232;36459.635403645625;36481.81759091187;36485.45271820872;36770;37029.259414811015;36590.45114323234;37839.43240851445;37861.81069094637;37952;38273.61726382701;31895.202619934687;33427.83002594898;33480.66519334873;33684;33843;23451.17920872761;24393.39016524601;24928.62607060932;25161.24516264515;25521.234362969142 23:16:56 INFO - PROCESS | 1671 | |2;jquery.html;413.1633442279386;414.75322183300926;416.25698128840025;420.8337706605891;421.203924582539;20290.797092029075;21045.789542104576;21075.262365817198;21147.942602869873;22054;12263.816042759367;12611.810822837664;15680.294386752596;21244.57510849786;21326.57346853062;5267.789288428458;5547.389787123413;5581.302337207849;5591.161325801122;6259.906101408483;6101.755929762804;6201.844953876167;6203.472704820073;6214.192155019864;6224;6014.248218972629;6043.425874541911;6158.7066715989695;6163.845903852417;6186.443220110189;6059.212302400681;6121.173641558377;6123.112148738408;6129.233845769279;6158.168647232634;5299.947000530023;5362;5455.481729235717;5462;5476.452354764491;25384.619230711553;25496.87251563749;25868.741312586822;25967;26029;2155.2564365293947;2349.682792822964;2454.570450171213;2492;2532.341591186286;9015.594298256594;10001.299909006373;10098.949505252427;10131.037551432602;10539.314944528658;1814.637072585488;1861.7393564900924;1869.140195510067;1918.2422942937462;2070.6169358668694;106545.99999999923;110350.97237915541;116615.83384166134;117483;118928.8107118935;11218.373335866254;12134.939325303318;12305.384730763426;12313.753724925631;12370;15326.00380975233;15330.386784528717;15353.309101090254;15354.539363819104;15378.38486460529;7710.614469276514;9134.132257435533;9176.44941303524;9190.632374704937;9301.488418136933;9267.119623635745;9283.350165488351;9288.535573221447;9307.813843723223;9418.387804792666;4803.279508073817;4848.200046992278;4872.634552408584;4884.5603895649565;4907.822122690529;2043.8058384453452;2106.9367918962457;2128.6274901892416;2138.3050508584774;2148.5380643161793;876.7632739160391;954.2604481526733;956.3544607389983;1022.1822541966397;1046.4453839465095;20468.488287792923;20582;21273.25543605997;22298.55402891933;22438.663420048713;993.6373223773415;1008.2841182760322;1029.1972261635935;1061.7982583309147;1128.5655022816275;11008.834867476995;11450.656480305604;11459.828102578467;11470.36912969778;11493.42532873353;638770;639507;646464;649778;669841.9523707149;132516;133442;139366.30316848352;139837;142420;936.442816524167;965.8068386322764;1103.3379972016726;1111.1555218034352;1121.1031175060082;18320;18533;18819.247230110643;18854.622907542045;18880.905595471933;49898;53219.93560128853;54631.90736185334;54856;56215;74707.8793818104;75347;76217.47565048558;77304.61347693225;79781.60109199649;6923.9653801730665;8073.475224110414;8385.580720963806;8421.284190843848;8499.872501912352;11470;12782.68043298925;12987.870121298665;13107.934460327637;13136.211827290394;10751.946240269062;10802.109630814733;10862.728431789268;10901.727456813325;11024.338539687324;10864.891351086388;10986.780264394827;11124.221304508606;11169.218154729091;11396.658100257006;7193.4604904631315;10276.280660353703;10995.395253261147;11677;11680.415979201176;8306.916930830614;8332.750017499484;8555.401121921406;8594.570271486526;8751.606177721891;10884.455777211266;11223.551057957917;11338.773224535298;11374.374409407232;11465.828012579985 23:16:56 INFO - PROCESS | 1671 | |3;mootools.html;1551.1701239836686;1673.983260167398;1955.2276850643987;2046.069038587443;2090.226616152024;8359.74920752377;9056.501892395916;9144.542772861356;9352.81294374113;9354.345195836295;9079.727608171748;9202.953985230064;9203.171714545706;9210.078992100787;9257.675981340655;2278.54429114177;2548.1845809341016;2559.2450227183026;2561.692596888376;2585.7672809447145;2521.0546045233036;2594.2606357188206;2602.193320070784;2607.8565678887653;2608.6347911292432;2567.7817385522253;2572.176903390916;2606.569915963864;2607.126612584777;2607.217834649607;2562.4362640219215;2588.4952434275324;2593.144262393406;2612.4513852090895;2626.461575377062;2561.078011915709;2593.922182334533;2600.5189040027467;2612.3860892690204;2644.4843255565174;9279.675211367638;9364.016778238254;9395.295352848563;9406.341556091076;9441.669541566012;5645.1532270159805;5776.624519406268;5779.479846813807;5810.564207684441;5831.504322132581;3633.8364773585254;3738.2710371477574;3766.5291838520184;3781.867634632802;3783.2244389900006;1046.3937855392012;1063.0060893065008;1064.440594529011;1102.779444111173;1117.3016864459712;12440.444944381952;12443.564475243413;12445.128840981135;12503;12539.059570532156;5037.79848806051;5046.520580544842;5106.744662766847;5107.948920510822;5145.279660847485;10628.468576571295;10634.042936135786;10641.308314959502;10643.84034239487;10655.360678359168;5661.179129026351;5750.338711048283;5789.739461724233;5795.82612521625;5804.4775970162045;4683.320918466803;5129;5223.52988231061;5239.29269548606;5248.606354523426;4281.100968796588;4297.076128632359;4368.541303163122;4409.140217657526;4429;1221.645722740413;1416.872481476672;1423.0678905317034;1427.2364285107417;1432.44134787433;858.7638399440079;971.1793534463367;978.3738407419257;994.7015895231401;1028.9504705200654;6064.241969753781;6186.969065154645;6228.688565571703;6248;6256.249250090018;475.6266330930203;487.3104557051732;492.46567474290794;498.464151037636;502.32939026400163;4107.178564287155;4111.506619205655;4140.855070072533;4166.104287578125;4195.265828480004;10979.61571345015;11290;11396.031337336253;11430.142739294586;11473.54105835774;10695.465226738632;11127.443627818577;11144.2199046066;11157.051650609788;11204.271722338022;8601.31189504838;8745.91254087451;8807.471551707045;8808.955955220312;8850.955745221361;4683.437987441393;6058.878822423615;6150.138980542817;6154.661493617894;6208.658523781235;10034.849477257701;10065.798684026426;10069.546870390703;10177.134943529883;10252.487375631039;8985.910140898508;10119.898801011896;10325.793484130125;10414.010668986433;10698.62554810609;6716.328367163244;7179.533330333512;7331.816704582428;7563.924360756542;7735.419843511647;8644.956775216084;8699.56502174876;8726;8754.868676969723;8768.473891566271;7190.856182876209;7368.521046131984;7648.502847314907;7851.882221766792;7931.801704957422;7545.132309784445;7590.430717696085;7622.009138811919;7706.7687969361;7721.9227807723455;6671.765723341197;7067.293270673097;7335.229800870832;7370.852582948418;7400.5189662671755;5004.524570165829;5027.095122877917;5149.433562308218;5228.137357335997;5247.7113758743635;5204.895902082013;5223.033738758342;5307.52232299095;5427.565794736491;5446.836594902159 23:16:56 INFO - PROCESS | 1671 | |4;prototype.html;301.2363658126649;321.6349443381761;346.2123668653812;346.8508541327228;348.5294851949868;6630.535862489628;6762.120924279849;7042.788716338511;7139.500234983547;7174.6771395287205;6855.760048398307;7035.577865328071;7039.612821294827;7059.752908648198;7068.893966590505;5198.974005129988;5205.817796377128;5238.580913526927;5241.764120614582;5251.816186433475;4768.403949506312;4823.252395878627;5227.895442091156;5245.370555533342;5260.92108618371;5169.508896654812;5185.2999845021;5189.7405129743365;5191.143461328877;5192.584593232532;5177.844664660066;5178.715170665612;5185.974070129663;5188;5194.610404219679;4067.5729048449784;4217.894552636178;4223.619874211336;4225.2817021106175;4239.215745087169;6653.4344580710695;6756.797296081126;6779.28817474163;6781.627010514419;6783.830404239884;5964.671943043131;5970.820875373745;5986.191864098335;5989.670568118751;6000.699965001732;6109.969450152766;7483.36391406731;7490.887636685454;7501.099868015873;7517.699292028312;4592.609628181609;4774.283857421415;4779.928301075487;4786.641001924835;4796.25658023007;7459.738909138208;7702.998610180696;7713.884291735629;7788.805279867992;7807.570583617899;4775.379200703886;4809.927851082237;4814.566688998007;4822.493638168012;4823.855284341475;4919.163742163841;4927.433345165352;4947.233178857283;4948;4960.70235785854;5929.14027466015;5930.466258036711;5936.465718085393;5937.910931336033;5955.553333499918;7525.774226773206;7549.849003020019;7557.659905304275;7590.468667193243;7615;1634.142075410419;1686.3086134684966;1711.794584649825;1713.1348668922365;1715.2881554154885;1063.3194755356578;1070.9932663296477;1072.31907738585;1078.218291738499;1084.452351562456;5931.9703401483575;7075.929240707527;7088.964555177191;7124.465665075037;7125;7792.142864284924;7797.961010194913;7821.882671759929;7825.37397008238;7847;7086.185088714864;7090.184628767654;7091.042709234187;7106.822329441805;7137.714491420389;3259.462188738879;3575.4458059000895;3918.921621567553;4141.295979683461;4144.357624568197;6663.833404164935;8177.427580069338;8179.059408168017;8190.877136842833;8226.218509241613;6686.264510903797;6995.580265184105;8134;8141.18588141193;8161.143079976636;8242.587870606445;8257.133001034925;8282.917170828336;8300.335973122257;8305.044919834176;7603.125640551186;7866.72466463671;7892.0924093729955;7905.525668459911;7924.762257132064;5595.496405323541;6097.207363042953;6708.865822683617;7509.136449308181;7709.267619576131;8193.59032048407;8213.79465513367;8215;8215.630296636786;8222.054463736747;4644.5123262056995;4727.479977202436;4784.114938736345;4848.684835485823;4851.95148048515;7683.270089341504;7736;7741.729039483591;7743.45795794289;7744.961275193588;5957.821265362046;7500.249975002456;7507.361874240751;7518.924810751822;7520.135184453858;7465.888011679937;7492.70029198826;7506.024216851774;7516.624168791429;7523.097228332416;7044.401225895856;7304.671289791866;7321.487495875238;7338.449616278694;7348.853022939618;7496.400287977058;7551.584662843597;7557.659905304165;7573.35626471756;7601.7719468416035;6416.615003099829;7099.876054535987;7378.372838308589;7390.334869861738;7412.703491860481 23:16:56 INFO - PROCESS | 1671 | |5;yui.html;708.5359089796184;720.2761224968906;737.1007371007372;771.4484143837155;774.5662429039736;15364.462243821468;15578.766318505232;15615.141167235812;15658.451954181592;15674.373025079012;14310.069845460037;14323.498677546288;14332.928335358309;14335.426582936696;14348.641283967907;784.4744021505577;957.6983250276176;976.8290549153905;986.5708416838662;989.6486747204747;972.125087421323;985.2758222706306;985.5564995751904;987.4618333008527;994.6817018554029;1019.9796004079914;1040.6669865642998;1043.1758910460726;1043.3218408034763;1046.8063408269456;980.186445250444;980.3676628574565;1027.3733022856088;1034.0848349210928;1037.8028174646868;733.1495465260326;772.9072511298624;774.5120574038376;779.0884664941975;783;14900.925495372561;14942.775858362133;15274.541763747106;15296.235188240544;15363.539093827203;13107.410166542528;13119.409626566827;13129.409176587076;13237.536686216032;13247.07270491066;9996.750081247954;10237.385756854612;10276.588936442533;10281.177505799518;10405.583776648926;3537.6992955598803;3605.981970090159;3608.386574282378;3748.83130259139;3840.8655697050467;83905.58047209786;83983.16016839875;85349.14650853536;87327;90674.54662726643;9451.102145296185;9474.242060635133;9491.905080949102;9540.713778586654;9580;21289;21337.573248534944;21359;21499.57000859974;21520;7096.787096387014;7456.51532650376;7482.139553951365;7527.322540971339;7607.505512141693;4161.500619925568;4167.791610419466;4189.958100419018;4261.637760790306;4267.997020700133;3669.6513831185994;3729.291434627412;3737.028372623138;3738.102855314705;3760.7931563764255;664.8000359351418;677.847484316025;679.6567733294654;685.7839780469136;689.3382352941233;503.13337517808606;580.9070548712185;585.9501942334949;592.9703514824241;607.1378642327905;7478.214787447239;7571.507851989603;7949.324307433817;8014.278714915686;8527.872081918777;568.4770011589347;576.495566379418;586.2144726067005;593.1991811055041;597.6115524908757;3339.5157702133056;3849.672777813917;3866.168773713665;3892.5328960524917;3956.188981258835;88866.11133888707;92454;93101.06898931059;93951;93952.65118372095;77756.22243777603;78872.6056369726;78907.60546197346;79919;80382;61436.69281653563;61971.69014154901;66318.00522992159;68649.97025044628;70394;8006.759797206093;8051.194880511902;8110.594470276581;8247.835043298981;8387.035490918623;42056.158876822905;42220.36669449899;43663.56336436595;44143.33784993292;45602.315965259884;58359.70820145872;60497.39502604918;60820;62538.68730656317;63603.3639663616;10660.680179594625;10830.296030757976;10937.671869843918;10954.123670106532;11006.009459148716;11783.76432471363;11967.222130561486;12021.956267434733;12150.270983741004;12157.270563766202;11165.38590377537;11254;11266.493007814504;11313.886861131283;11400.429978501208;9866.753331166492;11285.37930413835;11288;11506.367149806842;11691.240069395462;10882.483326110862;10892.128629709447;11011.44942752843;11013.669589912315;11241.49413276388;9206.907930920874;9401.341906066784;9512.904870951203;9850.852237216592;10155.339902906288;9405.20055795265;9628.32601717873;9672.613095476103;9707.077827606367;9774.755631108994 23:16:56 INFO - PROCESS | 1671 | __end_tp_report 23:16:56 INFO - PROCESS | 1671 | __start_cc_report 23:16:56 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,394 23:16:56 INFO - PROCESS | 1671 | __end_cc_report 23:16:56 INFO - PROCESS | 1671 | __startTimestamp1468477016023__endTimestamp 23:16:56 INFO - PROCESS | 1671 | 23:16:56 INFO - PROCESS | 1671 | ------- Summary: start ------- 23:16:56 INFO - PROCESS | 1671 | Number of tests: 6 23:16:56 INFO - PROCESS | 1671 | 23:16:56 INFO - PROCESS | 1671 | [#0] dojo.html Cycles:165 Average:5879.77 Median:6154.32 stddev:617.84 (10.0%) stddev-sans-first:592.79 23:16:56 INFO - PROCESS | 1671 | Values: 3578.9 3654.6 3656.3 3688.5 3705.8 5880.1 5894.8 5921.8 5943.3 5991.5 5913.4 5929.6 5934.9 5962.0 5974.1 5368.2 5373.7 5394.2 5415.0 5507.3 5352.2 5435.9 5450.1 5454.8 5475.6 5418.5 5419.8 5434.6 5442.0 5473.3 5398.9 5445.6 5447.7 5459.7 5472.1 5231.5 5309.8 5405.8 5441.8 5443.9 5658.9 5720.0 5815.0 5819.0 5937.8 6205.6 6280.7 6281.2 6282.8 6287.3 6284.0 6337.2 6341.7 6350.0 6416.2 5418.9 5825.2 5983.8 6093.4 6098.3 6440.6 6521.9 6528.0 6540.5 6567.5 6244.4 6252.5 6258.7 6259.8 6271.6 5349.5 6044.9 6110.8 6314.3 6367.7 6261.4 6274.4 6291.4 6295.5 6319.6 6237.1 6265.5 6292.3 6293.2 6299.2 4991.2 5000.5 5005.5 5074.7 5108.7 4513.1 4554.8 4559.7 4574.1 4599.4 6102.4 6154.3 6159.9 6165.4 6169.9 5428.9 6224.9 6247.9 6294.0 6322.4 6118.1 6139.6 6140.4 6145.0 6160.2 5635.7 5636.7 5646.7 5649.7 5669.9 5132.6 6085.9 6331.8 6609.9 6625.5 6336.8 6361.5 6367.6 6410.1 6417.9 5583.4 6642.7 6654.7 6681.2 6685.8 6185.8 6282.7 6294.8 6298.9 6306.4 6323.8 6362.0 6367.8 6376.9 6407.2 5606.9 6178.0 6254.7 6264.9 6266.2 6167.8 6182.4 6228.3 6240.9 6256.4 5718.8 6186.9 6209.9 6215.6 6219.3 5289.7 6124.1 6218.2 6229.7 6252.9 5251.4 6198.1 6201.8 6213.6 6217.1 23:16:56 INFO - PROCESS | 1671 | 23:16:56 INFO - PROCESS | 1671 | [#1] ext.html Cycles:180 Average:65883.24 Median:21052.03 stddev:139901.01 (664.5%) stddev-sans-first:140207.44 23:16:56 INFO - PROCESS | 1671 | Values: 537.5 548.3 555.8 615.3 629.8 33021.7 39745.4 39847.4 39864.2 39914.2 33853.5 41498.4 41948.8 41950.8 42079.0 9735.5 9897.0 9910.7 9914.8 9921.0 9662.3 9777.8 9790.4 9809.3 9900.6 9735.4 9805.4 9823.4 9829.5 9981.9 9826.8 9877.0 9889.1 9908.7 9921.7 9843.3 9958.7 9976.0 9976.8 9998.4 41562.8 41751.6 41969.8 42004.2 42038.5 3342.8 3369.6 3467.5 3772.5 3830.4 28287.0 29159.0 29478.7 29651.6 29876.0 2809.7 2824.8 2828.3 2863.6 2898.8 469853.0 474917.0 475521.6 475713.0 477332.0 60762.4 61699.7 62157.7 62342.0 62518.4 57797.7 58015.0 60435.4 64278.7 66500.0 16955.7 17804.5 18024.9 18080.6 18096.0 14034.6 14040.5 14100.6 14136.2 14152.2 16153.6 16179.4 16199.7 16230.8 16266.2 6313.8 6797.9 7042.3 7361.4 7433.8 1019.5 1030.5 1086.0 1132.9 1163.4 30136.0 30747.8 30758.7 30812.0 30819.8 1116.9 1169.7 1195.2 1224.7 1246.4 14349.6 14419.8 14494.7 14729.8 14856.7 610730.0 620454.0 620668.0 629692.9 629763.0 58808.0 59869.7 60249.7 60546.7 60570.7 1388.7 1549.2 1564.9 1572.7 1576.4 28125.0 28337.3 29028.0 29113.1 29148.6 49386.8 52306.7 52968.7 53024.0 53111.7 435958.0 465874.0 467402.0 467613.0 469659.0 25504.5 27202.3 28295.3 28326.0 28453.0 43032.8 43757.7 44545.9 44706.0 45401.8 30532.0 34204.5 36279.5 36391.0 36934.8 36459.6 36481.8 36485.5 36770.0 37029.3 36590.5 37839.4 37861.8 37952.0 38273.6 31895.2 33427.8 33480.7 33684.0 33843.0 23451.2 24393.4 24928.6 25161.2 25521.2 23:16:56 INFO - PROCESS | 1671 | 23:16:56 INFO - PROCESS | 1671 | [#2] jquery.html Cycles:180 Average:36624.27 Median:22176.28 stddev:108000.06 (487.0%) stddev-sans-first:108268.80 23:16:56 INFO - PROCESS | 1671 | Values: 413.2 414.8 416.3 420.8 421.2 20290.8 21045.8 21075.3 21147.9 22054.0 12263.8 12611.8 15680.3 21244.6 21326.6 5267.8 5547.4 5581.3 5591.2 6259.9 6101.8 6201.8 6203.5 6214.2 6224.0 6014.2 6043.4 6158.7 6163.8 6186.4 6059.2 6121.2 6123.1 6129.2 6158.2 5299.9 5362.0 5455.5 5462.0 5476.5 25384.6 25496.9 25868.7 25967.0 26029.0 2155.3 2349.7 2454.6 2492.0 2532.3 9015.6 10001.3 10098.9 10131.0 10539.3 1814.6 1861.7 1869.1 1918.2 2070.6 106546.0 110351.0 116615.8 117483.0 118928.8 11218.4 12134.9 12305.4 12313.8 12370.0 15326.0 15330.4 15353.3 15354.5 15378.4 7710.6 9134.1 9176.4 9190.6 9301.5 9267.1 9283.4 9288.5 9307.8 9418.4 4803.3 4848.2 4872.6 4884.6 4907.8 2043.8 2106.9 2128.6 2138.3 2148.5 876.8 954.3 956.4 1022.2 1046.4 20468.5 20582.0 21273.3 22298.6 22438.7 993.6 1008.3 1029.2 1061.8 1128.6 11008.8 11450.7 11459.8 11470.4 11493.4 638770.0 639507.0 646464.0 649778.0 669842.0 132516.0 133442.0 139366.3 139837.0 142420.0 936.4 965.8 1103.3 1111.2 1121.1 18320.0 18533.0 18819.2 18854.6 18880.9 49898.0 53219.9 54631.9 54856.0 56215.0 74707.9 75347.0 76217.5 77304.6 79781.6 6924.0 8073.5 8385.6 8421.3 8499.9 11470.0 12782.7 12987.9 13107.9 13136.2 10751.9 10802.1 10862.7 10901.7 11024.3 10864.9 10986.8 11124.2 11169.2 11396.7 7193.5 10276.3 10995.4 11677.0 11680.4 8306.9 8332.8 8555.4 8594.6 8751.6 10884.5 11223.6 11338.8 11374.4 11465.8 23:16:56 INFO - PROCESS | 1671 | 23:16:56 INFO - PROCESS | 1671 | [#3] mootools.html Cycles:180 Average:5990.87 Median:2751.49 stddev:3334.20 (121.2%) stddev-sans-first:3326.86 23:16:56 INFO - PROCESS | 1671 | Values: 1551.2 1674.0 1955.2 2046.1 2090.2 8359.7 9056.5 9144.5 9352.8 9354.3 9079.7 9203.0 9203.2 9210.1 9257.7 2278.5 2548.2 2559.2 2561.7 2585.8 2521.1 2594.3 2602.2 2607.9 2608.6 2567.8 2572.2 2606.6 2607.1 2607.2 2562.4 2588.5 2593.1 2612.5 2626.5 2561.1 2593.9 2600.5 2612.4 2644.5 9279.7 9364.0 9395.3 9406.3 9441.7 5645.2 5776.6 5779.5 5810.6 5831.5 3633.8 3738.3 3766.5 3781.9 3783.2 1046.4 1063.0 1064.4 1102.8 1117.3 12440.4 12443.6 12445.1 12503.0 12539.1 5037.8 5046.5 5106.7 5107.9 5145.3 10628.5 10634.0 10641.3 10643.8 10655.4 5661.2 5750.3 5789.7 5795.8 5804.5 4683.3 5129.0 5223.5 5239.3 5248.6 4281.1 4297.1 4368.5 4409.1 4429.0 1221.6 1416.9 1423.1 1427.2 1432.4 858.8 971.2 978.4 994.7 1029.0 6064.2 6187.0 6228.7 6248.0 6256.2 475.6 487.3 492.5 498.5 502.3 4107.2 4111.5 4140.9 4166.1 4195.3 10979.6 11290.0 11396.0 11430.1 11473.5 10695.5 11127.4 11144.2 11157.1 11204.3 8601.3 8745.9 8807.5 8809.0 8851.0 4683.4 6058.9 6150.1 6154.7 6208.7 10034.8 10065.8 10069.5 10177.1 10252.5 8985.9 10119.9 10325.8 10414.0 10698.6 6716.3 7179.5 7331.8 7563.9 7735.4 8645.0 8699.6 8726.0 8754.9 8768.5 7190.9 7368.5 7648.5 7851.9 7931.8 7545.1 7590.4 7622.0 7706.8 7721.9 6671.8 7067.3 7335.2 7370.9 7400.5 5004.5 5027.1 5149.4 5228.1 5247.7 5204.9 5223.0 5307.5 5427.6 5446.8 23:16:56 INFO - PROCESS | 1671 | 23:16:56 INFO - PROCESS | 1671 | [#4] prototype.html Cycles:180 Average:6080.52 Median:6819.80 stddev:1983.00 (29.1%) stddev-sans-first:1940.54 23:16:56 INFO - PROCESS | 1671 | Values: 301.2 321.6 346.2 346.9 348.5 6630.5 6762.1 7042.8 7139.5 7174.7 6855.8 7035.6 7039.6 7059.8 7068.9 5199.0 5205.8 5238.6 5241.8 5251.8 4768.4 4823.3 5227.9 5245.4 5260.9 5169.5 5185.3 5189.7 5191.1 5192.6 5177.8 5178.7 5186.0 5188.0 5194.6 4067.6 4217.9 4223.6 4225.3 4239.2 6653.4 6756.8 6779.3 6781.6 6783.8 5964.7 5970.8 5986.2 5989.7 6000.7 6110.0 7483.4 7490.9 7501.1 7517.7 4592.6 4774.3 4779.9 4786.6 4796.3 7459.7 7703.0 7713.9 7788.8 7807.6 4775.4 4809.9 4814.6 4822.5 4823.9 4919.2 4927.4 4947.2 4948.0 4960.7 5929.1 5930.5 5936.5 5937.9 5955.6 7525.8 7549.8 7557.7 7590.5 7615.0 1634.1 1686.3 1711.8 1713.1 1715.3 1063.3 1071.0 1072.3 1078.2 1084.5 5932.0 7075.9 7089.0 7124.5 7125.0 7792.1 7798.0 7821.9 7825.4 7847.0 7086.2 7090.2 7091.0 7106.8 7137.7 3259.5 3575.4 3918.9 4141.3 4144.4 6663.8 8177.4 8179.1 8190.9 8226.2 6686.3 6995.6 8134.0 8141.2 8161.1 8242.6 8257.1 8282.9 8300.3 8305.0 7603.1 7866.7 7892.1 7905.5 7924.8 5595.5 6097.2 6708.9 7509.1 7709.3 8193.6 8213.8 8215.0 8215.6 8222.1 4644.5 4727.5 4784.1 4848.7 4852.0 7683.3 7736.0 7741.7 7743.5 7745.0 5957.8 7500.2 7507.4 7518.9 7520.1 7465.9 7492.7 7506.0 7516.6 7523.1 7044.4 7304.7 7321.5 7338.4 7348.9 7496.4 7551.6 7557.7 7573.4 7601.8 6416.6 7099.9 7378.4 7390.3 7412.7 23:16:56 INFO - PROCESS | 1671 | 23:16:56 INFO - PROCESS | 1671 | [#5] yui.html Cycles:180 Average:18041.69 Median:29470.31 stddev:25403.01 (86.2%) stddev-sans-first:25440.93 23:16:56 INFO - PROCESS | 1671 | Values: 708.5 720.3 737.1 771.4 774.6 15364.5 15578.8 15615.1 15658.5 15674.4 14310.1 14323.5 14332.9 14335.4 14348.6 784.5 957.7 976.8 986.6 989.6 972.1 985.3 985.6 987.5 994.7 1020.0 1040.7 1043.2 1043.3 1046.8 980.2 980.4 1027.4 1034.1 1037.8 733.1 772.9 774.5 779.1 783.0 14900.9 14942.8 15274.5 15296.2 15363.5 13107.4 13119.4 13129.4 13237.5 13247.1 9996.8 10237.4 10276.6 10281.2 10405.6 3537.7 3606.0 3608.4 3748.8 3840.9 83905.6 83983.2 85349.1 87327.0 90674.5 9451.1 9474.2 9491.9 9540.7 9580.0 21289.0 21337.6 21359.0 21499.6 21520.0 7096.8 7456.5 7482.1 7527.3 7607.5 4161.5 4167.8 4190.0 4261.6 4268.0 3669.7 3729.3 3737.0 3738.1 3760.8 664.8 677.8 679.7 685.8 689.3 503.1 580.9 586.0 593.0 607.1 7478.2 7571.5 7949.3 8014.3 8527.9 568.5 576.5 586.2 593.2 597.6 3339.5 3849.7 3866.2 3892.5 3956.2 88866.1 92454.0 93101.1 93951.0 93952.7 77756.2 78872.6 78907.6 79919.0 80382.0 61436.7 61971.7 66318.0 68650.0 70394.0 8006.8 8051.2 8110.6 8247.8 8387.0 42056.2 42220.4 43663.6 44143.3 45602.3 58359.7 60497.4 60820.0 62538.7 63603.4 10660.7 10830.3 10937.7 10954.1 11006.0 11783.8 11967.2 12022.0 12150.3 12157.3 11165.4 11254.0 11266.5 11313.9 11400.4 9866.8 11285.4 11288.0 11506.4 11691.2 10882.5 10892.1 11011.4 11013.7 11241.5 9206.9 9401.3 9512.9 9850.9 10155.3 9405.2 9628.3 9672.6 9707.1 9774.8 23:16:56 INFO - PROCESS | 1671 | -------- Summary: end -------- 23:16:56 INFO - PROCESS | 1671 | 23:16:56 INFO - TEST-INFO | 1671: exit 0 23:16:56 INFO - TEST-OK | dromaeo_css | took 1110296ms 23:16:56 INFO - TEST-START | kraken 23:16:56 INFO - operating with platform_type : mac_ 23:16:56 INFO - Initialising browser for kraken test... 23:16:56 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmpnC5qgN/profile http://localhost:49275/getInfo.html) 23:16:59 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 23:16:59 INFO - PROCESS | 1679 | colorDepth:24 23:16:59 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 23:16:59 INFO - PROCESS | 1679 | __metrics 23:16:59 ERROR - PROCESS | 1679 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 23:16:59 INFO - TEST-INFO | 1679: exit 0 23:16:59 INFO - Browser initialized. 23:16:59 INFO - Running cycle 1/1 for kraken test... 23:16:59 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/tmpnC5qgN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:17:11 INFO - PROCESS | 1683 | RSS: Main: 170926080 23:17:11 INFO - PROCESS | 1683 | 23:17:14 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 23:17:15 INFO - PROCESS | 1683 | RSS: Main: 183791616 23:17:15 INFO - PROCESS | 1683 | 23:17:17 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 23:17:18 INFO - PROCESS | 1683 | RSS: Main: 193363968 23:17:18 INFO - PROCESS | 1683 | 23:17:21 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 23:17:22 INFO - PROCESS | 1683 | RSS: Main: 195993600 23:17:22 INFO - PROCESS | 1683 | 23:17:24 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 23:17:24 INFO - PROCESS | 1683 | RSS: Main: 197349376 23:17:24 INFO - PROCESS | 1683 | 23:17:26 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:17:27 INFO - PROCESS | 1683 | RSS: Main: 197619712 23:17:27 INFO - PROCESS | 1683 | 23:17:30 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 23:17:30 INFO - PROCESS | 1683 | RSS: Main: 197849088 23:17:30 INFO - PROCESS | 1683 | 23:17:33 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 23:17:34 INFO - PROCESS | 1683 | RSS: Main: 197763072 23:17:34 INFO - PROCESS | 1683 | 23:17:37 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 23:17:37 INFO - PROCESS | 1683 | RSS: Main: 197885952 23:17:37 INFO - PROCESS | 1683 | 23:17:39 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:17:39 INFO - PROCESS | 1683 | RSS: Main: 197779456 23:17:39 INFO - PROCESS | 1683 | 23:17:41 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:17:42 INFO - PROCESS | 1683 | RSS: Main: 197914624 23:17:42 INFO - PROCESS | 1683 | 23:17:44 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:17:45 INFO - PROCESS | 1683 | RSS: Main: 197996544 23:17:45 INFO - PROCESS | 1683 | 23:17:47 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:17:48 INFO - PROCESS | 1683 | RSS: Main: 198684672 23:17:48 INFO - PROCESS | 1683 | 23:17:51 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:17:51 INFO - PROCESS | 1683 | RSS: Main: 198090752 23:17:51 INFO - PROCESS | 1683 | 23:17:53 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 23:17:53 INFO - PROCESS | 1683 | RSS: Main: 199843840 23:17:53 INFO - PROCESS | 1683 | 23:17:53 INFO - PROCESS | 1683 | __start_tp_report 23:17:53 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 23:17:53 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 23:17:53 INFO - PROCESS | 1683 | |i|pagename|runs| 23:17:53 INFO - PROCESS | 1683 | |0;ai-astar;117;115;117;117;119;132;115;116;123;164 23:17:53 INFO - PROCESS | 1683 | |1;audio-beat-detection;155;124;139;157;121;143;138;120;173;147 23:17:53 INFO - PROCESS | 1683 | |2;audio-dft;196;199;201;198;195;192;199;195;196;196 23:17:53 INFO - PROCESS | 1683 | |3;audio-fft;65;82;73;140;57;55;59;67;123;57 23:17:53 INFO - PROCESS | 1683 | |4;audio-oscillator;78;78;127;76;82;125;157;108;77;123 23:17:53 INFO - PROCESS | 1683 | |5;imaging-gaussian-blur;88;85;99;85;88;84;88;86;87;84 23:17:53 INFO - PROCESS | 1683 | |6;imaging-darkroom;97;95;95;103;93;95;95;94;94;94 23:17:53 INFO - PROCESS | 1683 | |7;imaging-desaturate;92;90;89;108;122;88;90;94;91;91 23:17:53 INFO - PROCESS | 1683 | |8;json-parse-financial;56;62;63;64;65;65;61;85;91;82 23:17:53 INFO - PROCESS | 1683 | |9;json-stringify-tinderbox;62;63;72;65;72;69;68;66;72;91 23:17:53 INFO - PROCESS | 1683 | |10;stanford-crypto-aes;80;79;80;81;80;78;82;80;86;82 23:17:53 INFO - PROCESS | 1683 | |11;stanford-crypto-ccm;131;118;125;155;141;157;135;128;144;177 23:17:53 INFO - PROCESS | 1683 | |12;stanford-crypto-pbkdf2;163;164;165;164;162;161;161;192;203;148 23:17:53 INFO - PROCESS | 1683 | |13;stanford-crypto-sha256-iterative;67;68;76;89;96;95;71;60;62;58 23:17:53 INFO - PROCESS | 1683 | __end_tp_report 23:17:53 INFO - PROCESS | 1683 | __start_cc_report 23:17:53 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,1029 23:17:54 INFO - PROCESS | 1683 | __end_cc_report 23:17:54 INFO - PROCESS | 1683 | __startTimestamp1468477073990__endTimestamp 23:17:54 INFO - PROCESS | 1683 | 23:17:54 INFO - PROCESS | 1683 | ------- Summary: start ------- 23:17:54 INFO - PROCESS | 1683 | Number of tests: 14 23:17:54 INFO - PROCESS | 1683 | 23:17:54 INFO - PROCESS | 1683 | [#0] ai-astar Cycles:10 Average:123.50 Median:118.00 stddev:15.13 (12.8%) stddev-sans-first:15.86 23:17:54 INFO - PROCESS | 1683 | Values: 117.0 115.0 117.0 117.0 119.0 132.0 115.0 116.0 123.0 164.0 23:17:54 INFO - PROCESS | 1683 | 23:17:54 INFO - PROCESS | 1683 | [#1] audio-beat-detection Cycles:10 Average:141.70 Median:145.00 stddev:17.17 (11.8%) stddev-sans-first:17.53 23:17:54 INFO - PROCESS | 1683 | Values: 155.0 124.0 139.0 157.0 121.0 143.0 138.0 120.0 173.0 147.0 23:17:54 INFO - PROCESS | 1683 | 23:17:54 INFO - PROCESS | 1683 | [#2] audio-dft Cycles:10 Average:196.70 Median:197.00 stddev:2.58 (1.3%) stddev-sans-first:2.73 23:17:54 INFO - PROCESS | 1683 | Values: 196.0 199.0 201.0 198.0 195.0 192.0 199.0 195.0 196.0 196.0 23:17:54 INFO - PROCESS | 1683 | 23:17:54 INFO - PROCESS | 1683 | [#3] audio-fft Cycles:10 Average:77.80 Median:62.00 stddev:29.76 (48.0%) stddev-sans-first:31.20 23:17:54 INFO - PROCESS | 1683 | Values: 65.0 82.0 73.0 140.0 57.0 55.0 59.0 67.0 123.0 57.0 23:17:54 INFO - PROCESS | 1683 | 23:17:54 INFO - PROCESS | 1683 | [#4] audio-oscillator Cycles:10 Average:103.10 Median:76.50 stddev:28.86 (37.7%) stddev-sans-first:29.15 23:17:54 INFO - PROCESS | 1683 | Values: 78.0 78.0 127.0 76.0 82.0 125.0 157.0 108.0 77.0 123.0 23:17:54 INFO - PROCESS | 1683 | 23:17:54 INFO - PROCESS | 1683 | [#5] imaging-gaussian-blur Cycles:10 Average:87.40 Median:87.50 stddev:4.38 (5.0%) stddev-sans-first:4.64 23:17:54 INFO - PROCESS | 1683 | Values: 88.0 85.0 99.0 85.0 88.0 84.0 88.0 86.0 87.0 84.0 23:17:54 INFO - PROCESS | 1683 | 23:17:54 INFO - PROCESS | 1683 | [#6] imaging-darkroom Cycles:10 Average:95.50 Median:95.00 stddev:2.84 (3.0%) stddev-sans-first:2.96 23:17:54 INFO - PROCESS | 1683 | Values: 97.0 95.0 95.0 103.0 93.0 95.0 95.0 94.0 94.0 94.0 23:17:54 INFO - PROCESS | 1683 | 23:17:54 INFO - PROCESS | 1683 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:90.50 stddev:10.92 (12.1%) stddev-sans-first:11.50 23:17:54 INFO - PROCESS | 1683 | Values: 92.0 90.0 89.0 108.0 122.0 88.0 90.0 94.0 91.0 91.0 23:17:54 INFO - PROCESS | 1683 | 23:17:54 INFO - PROCESS | 1683 | [#8] json-parse-financial Cycles:10 Average:69.40 Median:65.00 stddev:11.94 (18.4%) stddev-sans-first:11.63 23:17:54 INFO - PROCESS | 1683 | Values: 56.0 62.0 63.0 64.0 65.0 65.0 61.0 85.0 91.0 82.0 23:17:54 INFO - PROCESS | 1683 | 23:17:54 INFO - PROCESS | 1683 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:70.50 stddev:8.25 (11.7%) stddev-sans-first:8.22 23:17:54 INFO - PROCESS | 1683 | Values: 62.0 63.0 72.0 65.0 72.0 69.0 68.0 66.0 72.0 91.0 23:17:54 INFO - PROCESS | 1683 | 23:17:54 INFO - PROCESS | 1683 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:80.50 stddev:2.20 (2.7%) stddev-sans-first:2.32 23:17:54 INFO - PROCESS | 1683 | Values: 80.0 79.0 80.0 81.0 80.0 78.0 82.0 80.0 86.0 82.0 23:17:54 INFO - PROCESS | 1683 | 23:17:54 INFO - PROCESS | 1683 | [#11] stanford-crypto-ccm Cycles:10 Average:141.10 Median:142.50 stddev:17.79 (12.5%) stddev-sans-first:18.48 23:17:54 INFO - PROCESS | 1683 | Values: 131.0 118.0 125.0 155.0 141.0 157.0 135.0 128.0 144.0 177.0 23:17:54 INFO - PROCESS | 1683 | 23:17:54 INFO - PROCESS | 1683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.30 Median:164.00 stddev:16.33 (10.0%) stddev-sans-first:17.21 23:17:54 INFO - PROCESS | 1683 | Values: 163.0 164.0 165.0 164.0 162.0 161.0 161.0 192.0 203.0 148.0 23:17:54 INFO - PROCESS | 1683 | 23:17:54 INFO - PROCESS | 1683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.20 Median:73.50 stddev:14.31 (19.5%) stddev-sans-first:14.94 23:17:54 INFO - PROCESS | 1683 | Values: 67.0 68.0 76.0 89.0 96.0 95.0 71.0 60.0 62.0 58.0 23:17:54 INFO - PROCESS | 1683 | -------- Summary: end -------- 23:17:54 INFO - PROCESS | 1683 | 23:17:54 INFO - TEST-INFO | 1683: exit 0 23:17:54 INFO - TEST-OK | kraken | took 58441ms 23:17:54 INFO - SUITE-END | took 1168s 23:17:55 INFO - Completed test suite (00:19:28) 23:17:55 INFO - javascript benchmark 23:17:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3578.928421431571, 3654.6162652921444, 3656.2687462507506, 3688.4836122942793, 3705.759125656832, 5880.088586269129, 5894.793682221123, 5921.786033863059, 5943.3165186003625, 5991.460768530831, 5913.408659134085, 5929.614575052618, 5934.9317122917855, 5962.0, 5974.133750606159, 5368.221607866857, 5373.704446255454, 5394.217838413428, 5415.025295446818, 5507.311586051744, 5352.2239275305055, 5435.945640543583, 5450.100733379008, 5454.781808727646, 5475.589330800206, 5418.539424148932, 5419.756110975016, 5434.565234781227, 5442.047641662713, 5473.261109750192, 5398.8920221595745, 5445.564354851603, 5447.700376479292, 5459.727013649322, 5472.069748142825, 5231.529162375405, 5309.840704778863, 5405.8107966221, 5441.782328706847, 5443.891122177574, 5658.943410565924, 5719.971400143014, 5814.97092514539, 5818.970905145447, 5937.821865344046, 6205.596636218676, 6280.685965701697, 6281.152044473984, 6282.78010269643, 6287.308396076428, 6283.968580157116, 6337.176167098294, 6341.714622841983, 6350.0, 6416.197975253093, 5418.891622167614, 5825.242718446617, 5983.790567330209, 6093.421124993119, 6098.2682078150465, 6440.645764482904, 6521.8695626088165, 6528.020796880506, 6540.509461790385, 6567.540272180901, 6244.375562443719, 6252.531060170505, 6258.655773932477, 6259.78090766821, 6271.623702577769, 5349.545288650431, 6044.909326360108, 6110.7861224856915, 6314.336994615591, 6367.713452894631, 6261.405166509175, 6274.372562743689, 6291.370862913764, 6295.464885484785, 6319.620822750558, 6237.09562113491, 6265.530085243625, 6292.276388215322, 6293.213348331458, 6299.244090709144, 4991.176455884811, 5000.549950504472, 5005.499450055038, 5074.695518268915, 5108.693478391308, 4513.142502924434, 4554.795034223468, 4559.697352836796, 4574.08518296342, 4599.425071866017, 6102.420270074336, 6154.323024467305, 6159.938400615936, 6165.445109940127, 6169.907451388232, 5428.945710542923, 6224.875502489925, 6247.875042499125, 6294.0, 6322.430981211621, 6118.131909153847, 6139.605553834008, 6140.416660417253, 6144.972159187458, 6160.168377269011, 5635.6618602883955, 5636.718164091779, 5646.717664116778, 5649.68926709035, 5669.914951275734, 5132.589392848563, 6085.90453718335, 6331.841703957438, 6609.900851487231, 6625.469962403093, 6336.841578960563, 6361.522885783677, 6367.61794292344, 6410.134631824831, 6417.935820641734, 5583.413741557078, 6642.667866606554, 6654.667266636552, 6681.164854393201, 6685.799426017227, 6185.8144255672405, 6282.685865706788, 6294.842628934313, 6298.905516417166, 6306.400891915261, 6323.778667746791, 6362.0, 6367.777127800505, 6376.904346434714, 6407.231132264158, 5606.906653202586, 6177.980633195472, 6254.749810007731, 6264.874702505833, 6266.154069200599, 6167.753289868355, 6182.350853160354, 6228.314885362516, 6240.906386404116, 6256.374362563707, 5718.828435146952, 6186.938130618636, 6209.906851397142, 6215.564910456224, 6219.315875253628, 5289.7355132242465, 6124.081387791867, 6218.19163508741, 6229.719662615284, 6252.937470625236, 5251.396089449762, 6198.0702894566175, 6201.844953876189, 6213.627182369072, 6217.09852071438], "value": 5845.431189775269, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.521605770864, 548.3133011365697, 555.8443635781982, 615.2770494668763, 629.8016124920653, 33021.66978330216, 39745.403818942665, 39847.402288965655, 39864.20271594566, 39914.20171596566, 33853.49219761699, 41498.37752433716, 41948.79025604876, 41950.790246048804, 42079.0, 9735.46454944976, 9896.95051524745, 9910.653127140551, 9914.752131196705, 9920.950395248014, 9662.32363734539, 9777.755556111118, 9790.412575245473, 9809.264305177141, 9900.603975840957, 9735.36720113194, 9805.362651427635, 9823.361481503714, 9829.459379734111, 9981.850272245922, 9826.754331141707, 9876.950615246878, 9889.06053924876, 9908.702738917844, 9921.652742154027, 9843.310968232227, 9958.651447199314, 9976.0, 9976.750581235454, 9998.400095994264, 41562.75311740653, 41751.58248417507, 41969.79015104905, 42004.159916801495, 42038.528651497356, 3342.7660063795543, 3369.6124945631323, 3467.4625433057918, 3772.490713753663, 3830.444585535082, 28287.009954651487, 29159.0, 29478.70521294781, 29651.55522667162, 29876.0, 2809.7330753578376, 2824.844633545154, 2828.278788908815, 2863.599096126544, 2898.840563769013, 469853.0, 474917.0, 475521.62239188584, 475713.0, 477332.0, 60762.39237607656, 61699.691501542206, 62157.689211553654, 62342.0, 62518.374816252166, 57797.71101144551, 58015.0, 60435.39564604386, 64278.67860660667, 66500.0, 16955.745663815054, 17804.46586602404, 18024.918504889487, 18080.643951703674, 18096.00471974054, 14034.578962631138, 14040.508582199778, 14100.647483812782, 14136.222507761966, 14152.150870947777, 16153.596160095856, 16179.433719819985, 16199.67600648004, 16230.837691622932, 16266.18669066542, 6313.842153946096, 6797.864042719118, 7042.330978557029, 7361.447891408059, 7433.8141546461775, 1019.4851599941982, 1030.5377714496212, 1085.9954542048574, 1132.881511573363, 1163.4299193395345, 30136.0, 30747.846260769, 30758.692413075583, 30812.0, 30819.845900770353, 1116.944152792357, 1169.6958790714305, 1195.1813008089487, 1224.6693392784077, 1246.3954981833804, 14349.56951291463, 14419.78370324446, 14494.710105797825, 14729.779053314209, 14856.702865942621, 610730.0, 620454.0, 620668.0, 629692.8515357394, 629763.0, 58808.0, 59869.70065149647, 60249.69875150596, 60546.69726651427, 60570.69714651487, 1388.7291978064181, 1549.1711934115194, 1564.8591626753646, 1572.7404978178702, 1576.408846682494, 28125.0, 28337.29156771097, 29028.0, 29113.126606201848, 29148.562771558867, 49386.76533086701, 52306.738466307426, 52968.73515632397, 53024.0, 53111.73444132755, 435958.0, 465874.0, 467402.0, 467613.0, 469659.0, 25504.489910202064, 27202.31994200161, 28295.29261768472, 28326.0, 28453.0, 43032.78483607562, 43757.68726938197, 44545.88635284144, 44706.0, 45401.772991134836, 30532.0, 34204.48693269653, 36279.45580816237, 36391.0, 36934.8153259232, 36459.635403645625, 36481.81759091187, 36485.45271820872, 36770.0, 37029.259414811015, 36590.45114323234, 37839.43240851445, 37861.81069094637, 37952.0, 38273.61726382701, 31895.202619934687, 33427.83002594898, 33480.66519334873, 33684.0, 33843.0, 23451.17920872761, 24393.39016524601, 24928.62607060932, 25161.24516264515, 25521.234362969142], "value": 19914.69015969798, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.1633442279386, 414.75322183300926, 416.25698128840025, 420.8337706605891, 421.203924582539, 20290.797092029075, 21045.789542104576, 21075.262365817198, 21147.942602869873, 22054.0, 12263.816042759367, 12611.810822837664, 15680.294386752596, 21244.57510849786, 21326.57346853062, 5267.789288428458, 5547.389787123413, 5581.302337207849, 5591.161325801122, 6259.906101408483, 6101.755929762804, 6201.844953876167, 6203.472704820073, 6214.192155019864, 6224.0, 6014.248218972629, 6043.425874541911, 6158.7066715989695, 6163.845903852417, 6186.443220110189, 6059.212302400681, 6121.173641558377, 6123.112148738408, 6129.233845769279, 6158.168647232634, 5299.947000530023, 5362.0, 5455.481729235717, 5462.0, 5476.452354764491, 25384.619230711553, 25496.87251563749, 25868.741312586822, 25967.0, 26029.0, 2155.2564365293947, 2349.682792822964, 2454.570450171213, 2492.0, 2532.341591186286, 9015.594298256594, 10001.299909006373, 10098.949505252427, 10131.037551432602, 10539.314944528658, 1814.637072585488, 1861.7393564900924, 1869.140195510067, 1918.2422942937462, 2070.6169358668694, 106545.99999999923, 110350.97237915541, 116615.83384166134, 117483.0, 118928.8107118935, 11218.373335866254, 12134.939325303318, 12305.384730763426, 12313.753724925631, 12370.0, 15326.00380975233, 15330.386784528717, 15353.309101090254, 15354.539363819104, 15378.38486460529, 7710.614469276514, 9134.132257435533, 9176.44941303524, 9190.632374704937, 9301.488418136933, 9267.119623635745, 9283.350165488351, 9288.535573221447, 9307.813843723223, 9418.387804792666, 4803.279508073817, 4848.200046992278, 4872.634552408584, 4884.5603895649565, 4907.822122690529, 2043.8058384453452, 2106.9367918962457, 2128.6274901892416, 2138.3050508584774, 2148.5380643161793, 876.7632739160391, 954.2604481526733, 956.3544607389983, 1022.1822541966397, 1046.4453839465095, 20468.488287792923, 20582.0, 21273.25543605997, 22298.55402891933, 22438.663420048713, 993.6373223773415, 1008.2841182760322, 1029.1972261635935, 1061.7982583309147, 1128.5655022816275, 11008.834867476995, 11450.656480305604, 11459.828102578467, 11470.36912969778, 11493.42532873353, 638770.0, 639507.0, 646464.0, 649778.0, 669841.9523707149, 132516.0, 133442.0, 139366.30316848352, 139837.0, 142420.0, 936.442816524167, 965.8068386322764, 1103.3379972016726, 1111.1555218034352, 1121.1031175060082, 18320.0, 18533.0, 18819.247230110643, 18854.622907542045, 18880.905595471933, 49898.0, 53219.93560128853, 54631.90736185334, 54856.0, 56215.0, 74707.8793818104, 75347.0, 76217.47565048558, 77304.61347693225, 79781.60109199649, 6923.9653801730665, 8073.475224110414, 8385.580720963806, 8421.284190843848, 8499.872501912352, 11470.0, 12782.68043298925, 12987.870121298665, 13107.934460327637, 13136.211827290394, 10751.946240269062, 10802.109630814733, 10862.728431789268, 10901.727456813325, 11024.338539687324, 10864.891351086388, 10986.780264394827, 11124.221304508606, 11169.218154729091, 11396.658100257006, 7193.4604904631315, 10276.280660353703, 10995.395253261147, 11677.0, 11680.415979201176, 8306.916930830614, 8332.750017499484, 8555.401121921406, 8594.570271486526, 8751.606177721891, 10884.455777211266, 11223.551057957917, 11338.773224535298, 11374.374409407232, 11465.828012579985], "value": 9797.960502617385, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1551.1701239836686, 1673.983260167398, 1955.2276850643987, 2046.069038587443, 2090.226616152024, 8359.74920752377, 9056.501892395916, 9144.542772861356, 9352.81294374113, 9354.345195836295, 9079.727608171748, 9202.953985230064, 9203.171714545706, 9210.078992100787, 9257.675981340655, 2278.54429114177, 2548.1845809341016, 2559.2450227183026, 2561.692596888376, 2585.7672809447145, 2521.0546045233036, 2594.2606357188206, 2602.193320070784, 2607.8565678887653, 2608.6347911292432, 2567.7817385522253, 2572.176903390916, 2606.569915963864, 2607.126612584777, 2607.217834649607, 2562.4362640219215, 2588.4952434275324, 2593.144262393406, 2612.4513852090895, 2626.461575377062, 2561.078011915709, 2593.922182334533, 2600.5189040027467, 2612.3860892690204, 2644.4843255565174, 9279.675211367638, 9364.016778238254, 9395.295352848563, 9406.341556091076, 9441.669541566012, 5645.1532270159805, 5776.624519406268, 5779.479846813807, 5810.564207684441, 5831.504322132581, 3633.8364773585254, 3738.2710371477574, 3766.5291838520184, 3781.867634632802, 3783.2244389900006, 1046.3937855392012, 1063.0060893065008, 1064.440594529011, 1102.779444111173, 1117.3016864459712, 12440.444944381952, 12443.564475243413, 12445.128840981135, 12503.0, 12539.059570532156, 5037.79848806051, 5046.520580544842, 5106.744662766847, 5107.948920510822, 5145.279660847485, 10628.468576571295, 10634.042936135786, 10641.308314959502, 10643.84034239487, 10655.360678359168, 5661.179129026351, 5750.338711048283, 5789.739461724233, 5795.82612521625, 5804.4775970162045, 4683.320918466803, 5129.0, 5223.52988231061, 5239.29269548606, 5248.606354523426, 4281.100968796588, 4297.076128632359, 4368.541303163122, 4409.140217657526, 4429.0, 1221.645722740413, 1416.872481476672, 1423.0678905317034, 1427.2364285107417, 1432.44134787433, 858.7638399440079, 971.1793534463367, 978.3738407419257, 994.7015895231401, 1028.9504705200654, 6064.241969753781, 6186.969065154645, 6228.688565571703, 6248.0, 6256.249250090018, 475.6266330930203, 487.3104557051732, 492.46567474290794, 498.464151037636, 502.32939026400163, 4107.178564287155, 4111.506619205655, 4140.855070072533, 4166.104287578125, 4195.265828480004, 10979.61571345015, 11290.0, 11396.031337336253, 11430.142739294586, 11473.54105835774, 10695.465226738632, 11127.443627818577, 11144.2199046066, 11157.051650609788, 11204.271722338022, 8601.31189504838, 8745.91254087451, 8807.471551707045, 8808.955955220312, 8850.955745221361, 4683.437987441393, 6058.878822423615, 6150.138980542817, 6154.661493617894, 6208.658523781235, 10034.849477257701, 10065.798684026426, 10069.546870390703, 10177.134943529883, 10252.487375631039, 8985.910140898508, 10119.898801011896, 10325.793484130125, 10414.010668986433, 10698.62554810609, 6716.328367163244, 7179.533330333512, 7331.816704582428, 7563.924360756542, 7735.419843511647, 8644.956775216084, 8699.56502174876, 8726.0, 8754.868676969723, 8768.473891566271, 7190.856182876209, 7368.521046131984, 7648.502847314907, 7851.882221766792, 7931.801704957422, 7545.132309784445, 7590.430717696085, 7622.009138811919, 7706.7687969361, 7721.9227807723455, 6671.765723341197, 7067.293270673097, 7335.229800870832, 7370.852582948418, 7400.5189662671755, 5004.524570165829, 5027.095122877917, 5149.433562308218, 5228.137357335997, 5247.7113758743635, 5204.895902082013, 5223.033738758342, 5307.52232299095, 5427.565794736491, 5446.836594902159], "value": 4770.3195359909005, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.2363658126649, 321.6349443381761, 346.2123668653812, 346.8508541327228, 348.5294851949868, 6630.535862489628, 6762.120924279849, 7042.788716338511, 7139.500234983547, 7174.6771395287205, 6855.760048398307, 7035.577865328071, 7039.612821294827, 7059.752908648198, 7068.893966590505, 5198.974005129988, 5205.817796377128, 5238.580913526927, 5241.764120614582, 5251.816186433475, 4768.403949506312, 4823.252395878627, 5227.895442091156, 5245.370555533342, 5260.92108618371, 5169.508896654812, 5185.2999845021, 5189.7405129743365, 5191.143461328877, 5192.584593232532, 5177.844664660066, 5178.715170665612, 5185.974070129663, 5188.0, 5194.610404219679, 4067.5729048449784, 4217.894552636178, 4223.619874211336, 4225.2817021106175, 4239.215745087169, 6653.4344580710695, 6756.797296081126, 6779.28817474163, 6781.627010514419, 6783.830404239884, 5964.671943043131, 5970.820875373745, 5986.191864098335, 5989.670568118751, 6000.699965001732, 6109.969450152766, 7483.36391406731, 7490.887636685454, 7501.099868015873, 7517.699292028312, 4592.609628181609, 4774.283857421415, 4779.928301075487, 4786.641001924835, 4796.25658023007, 7459.738909138208, 7702.998610180696, 7713.884291735629, 7788.805279867992, 7807.570583617899, 4775.379200703886, 4809.927851082237, 4814.566688998007, 4822.493638168012, 4823.855284341475, 4919.163742163841, 4927.433345165352, 4947.233178857283, 4948.0, 4960.70235785854, 5929.14027466015, 5930.466258036711, 5936.465718085393, 5937.910931336033, 5955.553333499918, 7525.774226773206, 7549.849003020019, 7557.659905304275, 7590.468667193243, 7615.0, 1634.142075410419, 1686.3086134684966, 1711.794584649825, 1713.1348668922365, 1715.2881554154885, 1063.3194755356578, 1070.9932663296477, 1072.31907738585, 1078.218291738499, 1084.452351562456, 5931.9703401483575, 7075.929240707527, 7088.964555177191, 7124.465665075037, 7125.0, 7792.142864284924, 7797.961010194913, 7821.882671759929, 7825.37397008238, 7847.0, 7086.185088714864, 7090.184628767654, 7091.042709234187, 7106.822329441805, 7137.714491420389, 3259.462188738879, 3575.4458059000895, 3918.921621567553, 4141.295979683461, 4144.357624568197, 6663.833404164935, 8177.427580069338, 8179.059408168017, 8190.877136842833, 8226.218509241613, 6686.264510903797, 6995.580265184105, 8134.0, 8141.18588141193, 8161.143079976636, 8242.587870606445, 8257.133001034925, 8282.917170828336, 8300.335973122257, 8305.044919834176, 7603.125640551186, 7866.72466463671, 7892.0924093729955, 7905.525668459911, 7924.762257132064, 5595.496405323541, 6097.207363042953, 6708.865822683617, 7509.136449308181, 7709.267619576131, 8193.59032048407, 8213.79465513367, 8215.0, 8215.630296636786, 8222.054463736747, 4644.5123262056995, 4727.479977202436, 4784.114938736345, 4848.684835485823, 4851.95148048515, 7683.270089341504, 7736.0, 7741.729039483591, 7743.45795794289, 7744.961275193588, 5957.821265362046, 7500.249975002456, 7507.361874240751, 7518.924810751822, 7520.135184453858, 7465.888011679937, 7492.70029198826, 7506.024216851774, 7516.624168791429, 7523.097228332416, 7044.401225895856, 7304.671289791866, 7321.487495875238, 7338.449616278694, 7348.853022939618, 7496.400287977058, 7551.584662843597, 7557.659905304165, 7573.35626471756, 7601.7719468416035, 6416.615003099829, 7099.876054535987, 7378.372838308589, 7390.334869861738, 7412.703491860481], "value": 5408.248816678707, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.5359089796184, 720.2761224968906, 737.1007371007372, 771.4484143837155, 774.5662429039736, 15364.462243821468, 15578.766318505232, 15615.141167235812, 15658.451954181592, 15674.373025079012, 14310.069845460037, 14323.498677546288, 14332.928335358309, 14335.426582936696, 14348.641283967907, 784.4744021505577, 957.6983250276176, 976.8290549153905, 986.5708416838662, 989.6486747204747, 972.125087421323, 985.2758222706306, 985.5564995751904, 987.4618333008527, 994.6817018554029, 1019.9796004079914, 1040.6669865642998, 1043.1758910460726, 1043.3218408034763, 1046.8063408269456, 980.186445250444, 980.3676628574565, 1027.3733022856088, 1034.0848349210928, 1037.8028174646868, 733.1495465260326, 772.9072511298624, 774.5120574038376, 779.0884664941975, 783.0, 14900.925495372561, 14942.775858362133, 15274.541763747106, 15296.235188240544, 15363.539093827203, 13107.410166542528, 13119.409626566827, 13129.409176587076, 13237.536686216032, 13247.07270491066, 9996.750081247954, 10237.385756854612, 10276.588936442533, 10281.177505799518, 10405.583776648926, 3537.6992955598803, 3605.981970090159, 3608.386574282378, 3748.83130259139, 3840.8655697050467, 83905.58047209786, 83983.16016839875, 85349.14650853536, 87327.0, 90674.54662726643, 9451.102145296185, 9474.242060635133, 9491.905080949102, 9540.713778586654, 9580.0, 21289.0, 21337.573248534944, 21359.0, 21499.57000859974, 21520.0, 7096.787096387014, 7456.51532650376, 7482.139553951365, 7527.322540971339, 7607.505512141693, 4161.500619925568, 4167.791610419466, 4189.958100419018, 4261.637760790306, 4267.997020700133, 3669.6513831185994, 3729.291434627412, 3737.028372623138, 3738.102855314705, 3760.7931563764255, 664.8000359351418, 677.847484316025, 679.6567733294654, 685.7839780469136, 689.3382352941233, 503.13337517808606, 580.9070548712185, 585.9501942334949, 592.9703514824241, 607.1378642327905, 7478.214787447239, 7571.507851989603, 7949.324307433817, 8014.278714915686, 8527.872081918777, 568.4770011589347, 576.495566379418, 586.2144726067005, 593.1991811055041, 597.6115524908757, 3339.5157702133056, 3849.672777813917, 3866.168773713665, 3892.5328960524917, 3956.188981258835, 88866.11133888707, 92454.0, 93101.06898931059, 93951.0, 93952.65118372095, 77756.22243777603, 78872.6056369726, 78907.60546197346, 79919.0, 80382.0, 61436.69281653563, 61971.69014154901, 66318.00522992159, 68649.97025044628, 70394.0, 8006.759797206093, 8051.194880511902, 8110.594470276581, 8247.835043298981, 8387.035490918623, 42056.158876822905, 42220.36669449899, 43663.56336436595, 44143.33784993292, 45602.315965259884, 58359.70820145872, 60497.39502604918, 60820.0, 62538.68730656317, 63603.3639663616, 10660.680179594625, 10830.296030757976, 10937.671869843918, 10954.123670106532, 11006.009459148716, 11783.76432471363, 11967.222130561486, 12021.956267434733, 12150.270983741004, 12157.270563766202, 11165.38590377537, 11254.0, 11266.493007814504, 11313.886861131283, 11400.429978501208, 9866.753331166492, 11285.37930413835, 11288.0, 11506.367149806842, 11691.240069395462, 10882.483326110862, 10892.128629709447, 11011.44942752843, 11013.669589912315, 11241.49413276388, 9206.907930920874, 9401.341906066784, 9512.904870951203, 9850.852237216592, 10155.339902906288, 9405.20055795265, 9628.32601717873, 9672.613095476103, 9707.077827606367, 9774.755631108994], "value": 6971.578725384303, "unit": "score"}], "name": "dromaeo_css", "value": 7679.78926530942, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 117.0, 117.0, 119.0, 132.0, 115.0, 116.0, 123.0, 164.0], "value": 123.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 124.0, 139.0, 157.0, 121.0, 143.0, 138.0, 120.0, 173.0, 147.0], "value": 141.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 199.0, 201.0, 198.0, 195.0, 192.0, 199.0, 195.0, 196.0, 196.0], "value": 196.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 82.0, 73.0, 140.0, 57.0, 55.0, 59.0, 67.0, 123.0, 57.0], "value": 77.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 127.0, 76.0, 82.0, 125.0, 157.0, 108.0, 77.0, 123.0], "value": 103.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 99.0, 85.0, 88.0, 84.0, 88.0, 86.0, 87.0, 84.0], "value": 87.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 95.0, 103.0, 93.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 95.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 89.0, 108.0, 122.0, 88.0, 90.0, 94.0, 91.0, 91.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 62.0, 63.0, 64.0, 65.0, 65.0, 61.0, 85.0, 91.0, 82.0], "value": 69.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 72.0, 65.0, 72.0, 69.0, 68.0, 66.0, 72.0, 91.0], "value": 70.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 80.0, 81.0, 80.0, 78.0, 82.0, 80.0, 86.0, 82.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 118.0, 125.0, 155.0, 141.0, 157.0, 135.0, 128.0, 144.0, 177.0], "value": 141.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 165.0, 164.0, 162.0, 161.0, 161.0, 192.0, 203.0, 148.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 76.0, 89.0, 96.0, 95.0, 71.0, 60.0, 62.0, 58.0], "value": 74.2, "unit": "score"}], "name": "kraken", "value": 1524.9999999999998, "alertThreshold": 2.0}]} 23:17:55 INFO - Return code: 0 23:17:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:17:55 ERROR - # TBPL SUCCESS # 23:17:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:17:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:17:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:17:55 INFO - 2016-07-13 23:17:55.301 screenresolution[1688:12015] starting screenresolution argv=screenresolution get 23:17:55 INFO - 2016-07-13 23:17:55.304 screenresolution[1688:12015] Display 0: 1600x1200x32@60 23:17:55 INFO - 2016-07-13 23:17:55.310 screenresolution[1689:12018] starting screenresolution argv=screenresolution list 23:17:55 INFO - Available Modes on Display 0 23:17:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:17:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:17:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:17:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:17:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:17:55 INFO - Intel Iris: 23:17:55 INFO - Chipset Model: Intel Iris 23:17:55 INFO - Type: GPU 23:17:55 INFO - Bus: Built-In 23:17:55 INFO - VRAM (Dynamic, Max): 1536 MB 23:17:55 INFO - Vendor: Intel (0x8086) 23:17:55 INFO - Device ID: 0x0a2e 23:17:55 INFO - Revision ID: 0x0009 23:17:55 INFO - Displays: 23:17:55 INFO - Display: 23:17:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:17:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:17:55 INFO - Display Serial Number: 1600x1200 60 23:17:55 INFO - Main Display: Yes 23:17:55 INFO - Mirror: Off 23:17:55 INFO - Online: Yes 23:17:55 INFO - Rotation: Supported 23:17:55 INFO - Return code: 0 23:17:55 INFO - Running post-action listener: _resource_record_post_action 23:17:55 INFO - Running post-run listener: _resource_record_post_run 23:17:56 INFO - Total resource usage - Wall time: 1192s; CPU: 54.0%; Read bytes: 31821312; Write bytes: 495352832; Read time: 198; Write time: 1562 23:17:56 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 193430016; Write bytes: 187672064; Read time: 17322; Write time: 409 23:17:56 INFO - run-tests - Wall time: 1171s; CPU: 54.0%; Read bytes: 30039552; Write bytes: 297936384; Read time: 184; Write time: 1124 23:17:56 INFO - Running post-run listener: _upload_blobber_files 23:17:56 INFO - Blob upload gear active. 23:17:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:17:56 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 23:17:56 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'] 23:17:56 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 23:17:57 INFO - (blobuploader) - INFO - Open directory for files ... 23:17:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:17:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:17:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:17:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:17:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:17:58 INFO - (blobuploader) - INFO - Done attempting. 23:17:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:17:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:17:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:17:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:17:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:17:59 INFO - (blobuploader) - INFO - Done attempting. 23:17:59 INFO - (blobuploader) - INFO - Iteration through files over. 23:17:59 INFO - Return code: 0 23:17:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:17:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:17:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9f4c9ac60719174a90969e9a77747b8a6f0f560931e148aac281f0fe495cd90f331a7022ea268560048cea1b1d749adf55cc4df0ce8f02768e1b6208583d2bc0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/91f47d1f56c1eb5a3742c0dceb1ffb065b3f138d01b6cc2378408b1e5f0b5cd98c1ce59393ac61ab5ab337315acea3c5e49476e3b5beb982e8a853d30ffd2aa6"} 23:17:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:17:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:17:59 INFO - Contents: 23:17:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9f4c9ac60719174a90969e9a77747b8a6f0f560931e148aac281f0fe495cd90f331a7022ea268560048cea1b1d749adf55cc4df0ce8f02768e1b6208583d2bc0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/91f47d1f56c1eb5a3742c0dceb1ffb065b3f138d01b6cc2378408b1e5f0b5cd98c1ce59393ac61ab5ab337315acea3c5e49476e3b5beb982e8a853d30ffd2aa6"} 23:17:59 INFO - Running post-run listener: copy_logs_to_upload_dir 23:17:59 INFO - Copying logs to upload dir... 23:17:59 INFO - mkdir: /builds/slave/test/build/upload/logs 23:17:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1290.646248 ========= master_lag: 0.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2016-07-13 23:17:59.233751) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 23:17:59.237103) ========= 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.SOoRzULKaB/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.uYCEYb4Mv6/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9f4c9ac60719174a90969e9a77747b8a6f0f560931e148aac281f0fe495cd90f331a7022ea268560048cea1b1d749adf55cc4df0ce8f02768e1b6208583d2bc0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/91f47d1f56c1eb5a3742c0dceb1ffb065b3f138d01b6cc2378408b1e5f0b5cd98c1ce59393ac61ab5ab337315acea3c5e49476e3b5beb982e8a853d30ffd2aa6"} build_url:https://queue.taskcluster.net/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011333 build_url: 'https://queue.taskcluster.net/v1/task/V_8pXVBJQB6mWuAnjEt6SA/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9f4c9ac60719174a90969e9a77747b8a6f0f560931e148aac281f0fe495cd90f331a7022ea268560048cea1b1d749adf55cc4df0ce8f02768e1b6208583d2bc0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/91f47d1f56c1eb5a3742c0dceb1ffb065b3f138d01b6cc2378408b1e5f0b5cd98c1ce59393ac61ab5ab337315acea3c5e49476e3b5beb982e8a853d30ffd2aa6"}' ========= master_lag: 0.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 23:17:59.313143) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:17:59.313468) ========= 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.SOoRzULKaB/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.uYCEYb4Mv6/Listeners TMPDIR=/var/folders/qd/d6crkgfx1f96h1r6sc2yq68h00000w/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.004975 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:17:59.368973) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 23:17:59.369279) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 23:17:59.370470) ========= ========= Total master_lag: 0.37 =========