builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0070 starttime: 1461776060.15 results: success (0) buildid: 20160427075503 builduid: a1f1896d7282419ab0e2294def8d59bc revision: e0cddb21b2849605a49f8ace1b786e0dd04ef4ce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 09:54:20.149673) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 09:54:20.150076) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 18 secs) (at 2016-04-27 09:54:20.150355) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 18 secs) (at 2016-04-27 09:54:38.890893) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-04-27 09:54:38.895183) ========= 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.n8QndI80IQ/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.915j0FKsJ8/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-27 09:54:38-- 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% 11.1M=0.001s 2016-04-27 09:54:39 (11.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.241557 ========= master_lag: 6.36 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-04-27 09:54:45.501190) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 5 secs) (at 2016-04-27 09:54:45.501523) ========= 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.n8QndI80IQ/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.915j0FKsJ8/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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.026905 ========= master_lag: 5.78 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 5 secs) (at 2016-04-27 09:54:51.303797) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-27 09:54:51.304282) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e0cddb21b2849605a49f8ace1b786e0dd04ef4ce --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 e0cddb21b2849605a49f8ace1b786e0dd04ef4ce --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.n8QndI80IQ/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.915j0FKsJ8/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-27 09:54:51,471 truncating revision to first 12 chars 2016-04-27 09:54:51,471 Setting DEBUG logging. 2016-04-27 09:54:51,471 attempt 1/10 2016-04-27 09:54:51,471 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e0cddb21b284?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 09:54:52,537 unpacking tar archive at: mozilla-beta-e0cddb21b284/testing/mozharness/ program finished with exit code 0 elapsedTime=1.318508 ========= master_lag: 0.18 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-27 09:54:52.805269) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 09:54:52.805591) ========= script_repo_revision: e0cddb21b2849605a49f8ace1b786e0dd04ef4ce ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 09:54:52.805979) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 09:54:52.810278) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 09:54:52.858564) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-04-27 09:54:52.859059) ========= /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.n8QndI80IQ/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.915j0FKsJ8/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 09:54:53 INFO - MultiFileLogger online at 20160427 09:54:53 in /builds/slave/test 09:54:53 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 09:54:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:54:53 INFO - {'append_to_log': False, 09:54:53 INFO - 'base_work_dir': '/builds/slave/test', 09:54:53 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:54:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:54:53 INFO - 'branch': 'Mozilla-Beta', 09:54:53 INFO - 'buildbot_json_path': 'buildprops.json', 09:54:53 INFO - 'config_files': ('talos/mac_config.py',), 09:54:53 INFO - 'default_actions': ('clobber', 09:54:53 INFO - 'read-buildbot-config', 09:54:53 INFO - 'download-and-extract', 09:54:53 INFO - 'populate-webroot', 09:54:53 INFO - 'create-virtualenv', 09:54:53 INFO - 'install', 09:54:53 INFO - 'run-tests'), 09:54:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:54:53 INFO - 'download_minidump_stackwalk': True, 09:54:53 INFO - 'download_symbols': 'ondemand', 09:54:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:54:53 INFO - 'tooltool.py': '/tools/tooltool.py', 09:54:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:54:53 INFO - '/tools/misc-python/virtualenv.py')}, 09:54:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:54:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:54:53 INFO - 'installer_path': 'installer.exe', 09:54:53 INFO - 'log_level': 'info', 09:54:53 INFO - 'log_name': 'talos', 09:54:53 INFO - 'log_to_console': True, 09:54:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:54:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:54:53 INFO - 'opt_config_files': (), 09:54:53 INFO - 'pip_index': False, 09:54:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:54:53 INFO - 'cmd': ('bash', 09:54:53 INFO - '-c', 09:54:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:54:53 INFO - 'enabled': True, 09:54:53 INFO - 'halt_on_failure': False, 09:54:53 INFO - 'name': 'check_screen_resolution'},), 09:54:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:54:53 INFO - 'cmd': ('bash', 09:54:53 INFO - '-c', 09:54:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:54:53 INFO - 'enabled': True, 09:54:53 INFO - 'halt_on_failure': False, 09:54:53 INFO - 'name': 'check_screen_resolution'},), 09:54:53 INFO - 'run_cmd_checks_enabled': True, 09:54:53 INFO - 'sps_profile': False, 09:54:53 INFO - 'sps_profile_interval': 0, 09:54:53 INFO - 'suite': 'dromaeojs-e10s', 09:54:53 INFO - 'system_bits': '32', 09:54:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:54:53 INFO - 'title': 't-yosemite-r7-0070', 09:54:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:54:53 INFO - 'use_talos_json': True, 09:54:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:54:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:54:53 INFO - 'work_dir': 'build'} 09:54:53 INFO - ##### 09:54:53 INFO - ##### Running clobber step. 09:54:53 INFO - ##### 09:54:53 INFO - Running pre-action listener: _resource_record_pre_action 09:54:53 INFO - Running main action method: clobber 09:54:53 INFO - rmtree: /builds/slave/test/build 09:54:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:54:55 INFO - Running post-action listener: _resource_record_post_action 09:54:55 INFO - ##### 09:54:55 INFO - ##### Running read-buildbot-config step. 09:54:55 INFO - ##### 09:54:55 INFO - Running pre-action listener: _resource_record_pre_action 09:54:55 INFO - Running main action method: read_buildbot_config 09:54:55 INFO - Using buildbot properties: 09:54:55 INFO - { 09:54:55 INFO - "project": "", 09:54:55 INFO - "product": "firefox", 09:54:55 INFO - "script_repo_revision": "production", 09:54:55 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 09:54:55 INFO - "repository": "", 09:54:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 09:54:55 INFO - "buildid": "20160427075503", 09:54:55 INFO - "pgo_build": "False", 09:54:55 INFO - "basedir": "/builds/slave/test", 09:54:55 INFO - "buildnumber": 8, 09:54:55 INFO - "slavename": "t-yosemite-r7-0070", 09:54:55 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:54:55 INFO - "platform": "yosemite_r7", 09:54:55 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:54:55 INFO - "branch": "mozilla-beta", 09:54:55 INFO - "repo_path": "releases/mozilla-beta", 09:54:55 INFO - "revision": "e0cddb21b2849605a49f8ace1b786e0dd04ef4ce", 09:54:55 INFO - "stage_platform": "macosx64", 09:54:55 INFO - "builduid": "a1f1896d7282419ab0e2294def8d59bc", 09:54:55 INFO - "slavebuilddir": "test" 09:54:55 INFO - } 09:54:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 09:54:55 INFO - Running post-action listener: _resource_record_post_action 09:54:55 INFO - ##### 09:54:55 INFO - ##### Running download-and-extract step. 09:54:55 INFO - ##### 09:54:55 INFO - Running pre-action listener: _resource_record_pre_action 09:54:55 INFO - Running main action method: download_and_extract 09:54:55 INFO - mkdir: /builds/slave/test/build/tests 09:54:55 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')]} 09:54:55 INFO - https://queue.taskcluster.net/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:54:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 09:54:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 09:54:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 09:54:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 09:54:59 INFO - Downloaded 1241 bytes. 09:54:59 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 09:54:59 INFO - Using the following test package requirements: 09:54:59 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 09:54:59 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 09:54:59 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 09:54:59 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 09:54:59 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 09:54:59 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:54:59 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 09:54:59 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 09:54:59 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 09:54:59 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 09:54:59 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 09:54:59 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 09:54:59 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 09:54:59 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 09:54:59 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 09:54:59 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 09:54:59 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 09:54:59 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 09:54:59 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 09:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:54:59 INFO - https://queue.taskcluster.net/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:54:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 09:54:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 09:54:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 09:54:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 09:55:01 INFO - Downloaded 17745647 bytes. 09:55:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:55:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:55:04 INFO - Return code: 0 09:55:04 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 09:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:04 INFO - https://queue.taskcluster.net/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:55:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 09:55:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 09:55:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 09:55:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 09:55:09 INFO - Downloaded 17745647 bytes. 09:55:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:55:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:55:12 INFO - Return code: 0 09:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:12 INFO - https://queue.taskcluster.net/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:55:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 09:55:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 09:55:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 09:55:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 09:55:14 INFO - Downloaded 10845194 bytes. 09:55:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:55:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 09:55:14 INFO - Return code: 0 09:55:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:14 INFO - https://queue.taskcluster.net/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 09:55:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 09:55:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 09:55:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 09:55:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 09:55:18 INFO - Downloaded 88299148 bytes. 09:55:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 09:55:18 INFO - mkdir: /builds/slave/test/properties 09:55:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:55:18 INFO - Writing to file /builds/slave/test/properties/build_url 09:55:18 INFO - Contents: 09:55:18 INFO - build_url:https://queue.taskcluster.net/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 09:55:19 INFO - Running post-action listener: _resource_record_post_action 09:55:19 INFO - Running post-action listener: set_extra_try_arguments 09:55:19 INFO - ##### 09:55:19 INFO - ##### Running populate-webroot step. 09:55:19 INFO - ##### 09:55:19 INFO - Running pre-action listener: _resource_record_pre_action 09:55:19 INFO - Running main action method: populate_webroot 09:55:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:55:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:55:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:55:19 INFO - '--tppagecycles', 09:55:19 INFO - '7'], 09:55:19 INFO - 'tests': ['tsvgm']}}, 09:55:19 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:55:19 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:55:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:55:19 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:55:19 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:55:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:55:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:55:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:19 INFO - 'talos_options': ['--e10s'], 09:55:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:55:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:19 INFO - 'tests': ['damp', 'tps']}, 09:55:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:19 INFO - 'talos_options': ['--e10s'], 09:55:19 INFO - 'tests': ['damp', 'tps']}, 09:55:19 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:55:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:55:19 INFO - 'other': {'tests': ['a11yr', 09:55:19 INFO - 'ts_paint', 09:55:19 INFO - 'tpaint', 09:55:19 INFO - 'sessionrestore', 09:55:19 INFO - 'sessionrestore_no_auto_restore', 09:55:19 INFO - 'tabpaint']}, 09:55:19 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:55:19 INFO - 'tests': ['a11yr', 09:55:19 INFO - 'ts_paint', 09:55:19 INFO - 'tpaint', 09:55:19 INFO - 'sessionrestore', 09:55:19 INFO - 'sessionrestore_no_auto_restore', 09:55:19 INFO - 'tabpaint']}, 09:55:19 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:55:19 INFO - 'tests': ['a11yr', 09:55:19 INFO - 'ts_paint', 09:55:19 INFO - 'tpaint', 09:55:19 INFO - 'sessionrestore', 09:55:19 INFO - 'sessionrestore_no_auto_restore', 09:55:19 INFO - 'tabpaint']}, 09:55:19 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:55:19 INFO - 'tests': ['a11yr', 09:55:19 INFO - 'ts_paint', 09:55:19 INFO - 'tpaint', 09:55:19 INFO - 'sessionrestore', 09:55:19 INFO - 'sessionrestore_no_auto_restore', 09:55:19 INFO - 'tabpaint']}, 09:55:19 INFO - 'other_l64': {'tests': ['a11yr', 09:55:19 INFO - 'ts_paint', 09:55:19 INFO - 'tpaint', 09:55:19 INFO - 'sessionrestore', 09:55:19 INFO - 'sessionrestore_no_auto_restore', 09:55:19 INFO - 'tabpaint']}, 09:55:19 INFO - 'other_nol64': {'tests': ['a11yr', 09:55:19 INFO - 'ts_paint', 09:55:19 INFO - 'tpaint', 09:55:19 INFO - 'sessionrestore', 09:55:19 INFO - 'sessionrestore_no_auto_restore', 09:55:19 INFO - 'tabpaint']}, 09:55:19 INFO - 'svgr': {'tests': ['tsvgx', 09:55:19 INFO - 'tsvgr_opacity', 09:55:19 INFO - 'tart', 09:55:19 INFO - 'tscrollx', 09:55:19 INFO - 'cart']}, 09:55:19 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:55:19 INFO - 'tests': ['tsvgx', 09:55:19 INFO - 'tsvgr_opacity', 09:55:19 INFO - 'tart', 09:55:19 INFO - 'tscrollx', 09:55:19 INFO - 'cart']}, 09:55:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:19 INFO - 'tests': ['tp5o']}, 09:55:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:19 INFO - 'talos_options': ['--e10s'], 09:55:19 INFO - 'tests': ['tp5o']}, 09:55:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:19 INFO - 'talos_options': ['--xperf_path', 09:55:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:55:19 INFO - 'tests': ['tp5n']}, 09:55:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:55:19 INFO - 'talos_options': ['--e10s', 09:55:19 INFO - '--xperf_path', 09:55:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:55:19 INFO - 'tests': ['tp5n']}}, 09:55:19 INFO - 'talos.zip': {'path': '', 09:55:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:55:19 INFO - Running post-action listener: _resource_record_post_action 09:55:19 INFO - ##### 09:55:19 INFO - ##### Running create-virtualenv step. 09:55:19 INFO - ##### 09:55:19 INFO - Running pre-action listener: _resource_record_pre_action 09:55:19 INFO - Running main action method: create_virtualenv 09:55:19 INFO - Creating virtualenv /builds/slave/test/build/venv 09:55:19 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 09:55:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:55:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:55:19 INFO - Using real prefix '/tools/python27' 09:55:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:55:20 INFO - Installing distribute.............................................................................................................................................................................................done. 09:55:23 INFO - Installing pip.................done. 09:55:23 INFO - Return code: 0 09:55:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:55: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')]} 09:55:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55: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')]} 09:55:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db564c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd2a493560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f3d30>, '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 0x10d857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9eab20>, '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.n8QndI80IQ/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.915j0FKsJ8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 09:55:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:55:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:55:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n8QndI80IQ/Render', 09:55:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:23 INFO - 'HOME': '/Users/cltbld', 09:55:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:23 INFO - 'LOGNAME': 'cltbld', 09:55:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:23 INFO - 'MOZ_NO_REMOTE': '1', 09:55:23 INFO - 'NO_EM_RESTART': '1', 09:55:23 INFO - 'PAGER': '/bin/cat', 09:55:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:23 INFO - 'PWD': '/builds/slave/test', 09:55:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:23 INFO - 'SHELL': '/bin/bash', 09:55:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.915j0FKsJ8/Listeners', 09:55:23 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 09:55:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:23 INFO - 'USER': 'cltbld', 09:55:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:23 INFO - 'XPC_FLAGS': '0x0', 09:55:23 INFO - 'XPC_SERVICE_NAME': '0', 09:55:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:23 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 09:55:23 INFO - Cleaning up... 09:55:23 INFO - Return code: 0 09:55:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:55: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')]} 09:55:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55: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')]} 09:55:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10db4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db564c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd2a493560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f3d30>, '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 0x10d857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9eab20>, '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.n8QndI80IQ/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.915j0FKsJ8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 09:55:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:55:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:55:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n8QndI80IQ/Render', 09:55:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:23 INFO - 'HOME': '/Users/cltbld', 09:55:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:23 INFO - 'LOGNAME': 'cltbld', 09:55:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:23 INFO - 'MOZ_NO_REMOTE': '1', 09:55:23 INFO - 'NO_EM_RESTART': '1', 09:55:23 INFO - 'PAGER': '/bin/cat', 09:55:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:23 INFO - 'PWD': '/builds/slave/test', 09:55:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:23 INFO - 'SHELL': '/bin/bash', 09:55:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.915j0FKsJ8/Listeners', 09:55:23 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 09:55:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:23 INFO - 'USER': 'cltbld', 09:55:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:23 INFO - 'XPC_FLAGS': '0x0', 09:55:23 INFO - 'XPC_SERVICE_NAME': '0', 09:55:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:24 INFO - Downloading/unpacking psutil>=0.7.1 09:55:24 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 09:55:24 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 09:55:24 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 09:55:24 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 09:55:24 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 09:55:24 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 09:55:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:55:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:55:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:55:27 INFO - Installing collected packages: psutil 09:55:27 INFO - Running setup.py install for psutil 09:55:27 INFO - building 'psutil._psutil_osx' extension 09:55:27 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 09:55:27 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 09:55:27 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 09:55:27 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 09:55:27 INFO - building 'psutil._psutil_posix' extension 09:55:28 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 09:55:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:55:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:55:28 INFO - ^ 09:55:28 INFO - 1 warning generated. 09:55:28 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 09:55:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:55:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:55:28 INFO - Successfully installed psutil 09:55:28 INFO - Cleaning up... 09:55:28 INFO - Return code: 0 09:55:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:55:28 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')]} 09:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:28 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')]} 09:55:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:28 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 0x10db4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db564c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd2a493560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f3d30>, '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 0x10d857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9eab20>, '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.n8QndI80IQ/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.915j0FKsJ8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 09:55:28 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 09:55:28 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 09:55:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n8QndI80IQ/Render', 09:55:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:28 INFO - 'HOME': '/Users/cltbld', 09:55:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:28 INFO - 'LOGNAME': 'cltbld', 09:55:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:28 INFO - 'MOZ_NO_REMOTE': '1', 09:55:28 INFO - 'NO_EM_RESTART': '1', 09:55:28 INFO - 'PAGER': '/bin/cat', 09:55:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:28 INFO - 'PWD': '/builds/slave/test', 09:55:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:28 INFO - 'SHELL': '/bin/bash', 09:55:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.915j0FKsJ8/Listeners', 09:55:28 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 09:55:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:28 INFO - 'USER': 'cltbld', 09:55:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:28 INFO - 'XPC_FLAGS': '0x0', 09:55:28 INFO - 'XPC_SERVICE_NAME': '0', 09:55:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:55:28 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 09:55:28 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 09:55:28 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 09:55:28 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 09:55:28 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 09:55:28 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 09:55:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:55:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:55:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:55:31 INFO - Installing collected packages: mozsystemmonitor 09:55:31 INFO - Running setup.py install for mozsystemmonitor 09:55:31 INFO - Successfully installed mozsystemmonitor 09:55:31 INFO - Cleaning up... 09:55:31 INFO - Return code: 0 09:55:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:55: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')]} 09:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55: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')]} 09:55:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55: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', '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 0x10db4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db564c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd2a493560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f3d30>, '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 0x10d857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9eab20>, '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.n8QndI80IQ/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.915j0FKsJ8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 09:55: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:55: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 blobuploader==1.2.4 09:55:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n8QndI80IQ/Render', 09:55:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:31 INFO - 'HOME': '/Users/cltbld', 09:55:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:31 INFO - 'LOGNAME': 'cltbld', 09:55:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:31 INFO - 'MOZ_NO_REMOTE': '1', 09:55:31 INFO - 'NO_EM_RESTART': '1', 09:55:31 INFO - 'PAGER': '/bin/cat', 09:55:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:31 INFO - 'PWD': '/builds/slave/test', 09:55:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:31 INFO - 'SHELL': '/bin/bash', 09:55:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.915j0FKsJ8/Listeners', 09:55:31 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 09:55:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:31 INFO - 'USER': 'cltbld', 09:55:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:31 INFO - 'XPC_FLAGS': '0x0', 09:55:31 INFO - 'XPC_SERVICE_NAME': '0', 09:55:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:31 INFO - Downloading/unpacking blobuploader==1.2.4 09:55: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 09:55: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 09:55: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 09:55: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 09:55: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 09:55: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 09:55:34 INFO - Downloading blobuploader-1.2.4.tar.gz 09:55:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:55:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:55:34 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 09:55:34 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 09:55:34 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 09:55:34 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 09:55:34 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 09:55:34 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 09:55:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:55:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:55:34 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 09:55:34 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 09:55:34 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 09:55:34 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 09:55:34 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 09:55:34 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 09:55:35 INFO - Downloading docopt-0.6.1.tar.gz 09:55:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:55:35 INFO - Installing collected packages: blobuploader, requests, docopt 09:55:35 INFO - Running setup.py install for blobuploader 09:55:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:55:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:55:35 INFO - Running setup.py install for requests 09:55:35 INFO - Running setup.py install for docopt 09:55:35 INFO - Successfully installed blobuploader requests docopt 09:55:35 INFO - Cleaning up... 09:55:36 INFO - Return code: 0 09:55:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:55: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')]} 09:55:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55: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')]} 09:55:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:36 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 0x10db4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db564c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd2a493560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f3d30>, '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 0x10d857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9eab20>, '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.n8QndI80IQ/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.915j0FKsJ8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 09:55:36 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 09:55:36 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 09:55:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n8QndI80IQ/Render', 09:55:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:36 INFO - 'HOME': '/Users/cltbld', 09:55:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:36 INFO - 'LOGNAME': 'cltbld', 09:55:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:36 INFO - 'MOZ_NO_REMOTE': '1', 09:55:36 INFO - 'NO_EM_RESTART': '1', 09:55:36 INFO - 'PAGER': '/bin/cat', 09:55:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:36 INFO - 'PWD': '/builds/slave/test', 09:55:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:36 INFO - 'SHELL': '/bin/bash', 09:55:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.915j0FKsJ8/Listeners', 09:55:36 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 09:55:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:36 INFO - 'USER': 'cltbld', 09:55:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:36 INFO - 'XPC_FLAGS': '0x0', 09:55:36 INFO - 'XPC_SERVICE_NAME': '0', 09:55:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:55:36 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-xw7xKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:55:36 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-5B4z2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:55:36 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-hpI5mF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:55:36 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-K3i6Pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:55:36 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-swvJKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:55:36 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-lUd7DF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:55:36 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-iFjh3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:55:37 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-LkQlJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:55:37 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-WhqPLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:55:37 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-BoAjyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:55:37 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-FFjxdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:55:37 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-DlBUse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:55:37 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-LsNIn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:55:37 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-mzbxsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:55:37 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-uZg9QJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:55:37 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-g7dPkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:55:38 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-BaxlS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:55:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:55:38 INFO - Running setup.py install for manifestparser 09:55:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:55:38 INFO - Running setup.py install for mozcrash 09:55:38 INFO - Running setup.py install for mozdebug 09:55:38 INFO - Running setup.py install for mozdevice 09:55:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:55:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:55:38 INFO - Running setup.py install for mozfile 09:55:38 INFO - Running setup.py install for mozhttpd 09:55:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:55:38 INFO - Running setup.py install for mozinfo 09:55:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:55:39 INFO - Running setup.py install for mozInstall 09:55:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:55:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:55:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:55:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:55:39 INFO - Running setup.py install for mozleak 09:55:39 INFO - Running setup.py install for mozlog 09:55:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:55:39 INFO - Running setup.py install for moznetwork 09:55:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:55:39 INFO - Running setup.py install for mozprocess 09:55:39 INFO - Running setup.py install for mozprofile 09:55:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:55:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:55:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:55:40 INFO - Running setup.py install for mozrunner 09:55:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:55:40 INFO - Running setup.py install for mozscreenshot 09:55:40 INFO - Running setup.py install for moztest 09:55:40 INFO - Running setup.py install for mozversion 09:55:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:55:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:55:40 INFO - Cleaning up... 09:55:40 INFO - Return code: 0 09:55:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:55: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')]} 09:55:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55: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')]} 09:55:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:40 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 0x10db4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db564c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd2a493560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f3d30>, '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 0x10d857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9eab20>, '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.n8QndI80IQ/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.915j0FKsJ8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 09:55:40 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 09:55:40 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 09:55:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n8QndI80IQ/Render', 09:55:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:40 INFO - 'HOME': '/Users/cltbld', 09:55:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:40 INFO - 'LOGNAME': 'cltbld', 09:55:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:40 INFO - 'MOZ_NO_REMOTE': '1', 09:55:40 INFO - 'NO_EM_RESTART': '1', 09:55:40 INFO - 'PAGER': '/bin/cat', 09:55:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:40 INFO - 'PWD': '/builds/slave/test', 09:55:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:40 INFO - 'SHELL': '/bin/bash', 09:55:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.915j0FKsJ8/Listeners', 09:55:40 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 09:55:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:40 INFO - 'USER': 'cltbld', 09:55:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:40 INFO - 'XPC_FLAGS': '0x0', 09:55:40 INFO - 'XPC_SERVICE_NAME': '0', 09:55:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:55:40 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-lpqqHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:55:41 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)) 09:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:55:41 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-yiIssB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:55:41 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)) 09:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:55:41 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-5pH2fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:55:41 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)) 09:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:55:41 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-UjC4Jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:55:41 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)) 09:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:55:41 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-b5ZNV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:55:41 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)) 09:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:55:41 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-X8Jr1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:55:41 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)) 09:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:55:41 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-moUjtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:55:41 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)) 09:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:55:41 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-EsKc4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:55:41 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)) 09:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:55:41 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-zjjZs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:55:41 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)) 09:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:55:41 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-I9czXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:55:41 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)) 09:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:55:41 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-C36jlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:55:42 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)) 09:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:55:42 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-hyNCHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:55:42 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)) 09:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:55:42 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-wOTco5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:55:42 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)) 09:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:55:42 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-tBaYHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:55:42 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)) 09:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:55:42 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-XrYlXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:55:42 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)) 09:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:55:42 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-wzNAdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:55:42 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)) 09:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:55:42 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-paCDKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:55:42 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)) 09:55:42 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)) 09:55:42 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)) 09:55:42 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)) 09:55:42 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)) 09:55:42 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)) 09:55:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:55: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 09:55: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 09:55: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 09:55: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 09:55: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 09:55: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 09:55:45 INFO - Downloading blessings-1.6.tar.gz 09:55:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:55:45 INFO - Installing collected packages: blessings 09:55:45 INFO - Running setup.py install for blessings 09:55:45 INFO - Successfully installed blessings 09:55:45 INFO - Cleaning up... 09:55:45 INFO - Return code: 0 09:55:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:55:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:55:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:55:45 INFO - Reading from file tmpfile_stdout 09:55:45 INFO - Current package versions: 09:55:45 INFO - blessings == 1.6 09:55:45 INFO - blobuploader == 1.2.4 09:55:45 INFO - docopt == 0.6.1 09:55:45 INFO - manifestparser == 1.1 09:55:45 INFO - mozInstall == 1.12 09:55:45 INFO - mozcrash == 0.17 09:55:45 INFO - mozdebug == 0.1 09:55:45 INFO - mozdevice == 0.48 09:55:45 INFO - mozfile == 1.2 09:55:45 INFO - mozhttpd == 0.7 09:55:45 INFO - mozinfo == 0.9 09:55:45 INFO - mozleak == 0.1 09:55:45 INFO - mozlog == 3.1 09:55:45 INFO - moznetwork == 0.27 09:55:45 INFO - mozprocess == 0.22 09:55:45 INFO - mozprofile == 0.28 09:55:45 INFO - mozrunner == 6.11 09:55:45 INFO - mozscreenshot == 0.1 09:55:45 INFO - mozsystemmonitor == 0.0 09:55:45 INFO - moztest == 0.7 09:55:45 INFO - mozversion == 1.4 09:55:45 INFO - psutil == 3.1.1 09:55:45 INFO - requests == 1.2.3 09:55:45 INFO - wsgiref == 0.1.2 09:55:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:55:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:45 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 0x10db4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db564c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd2a493560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f3d30>, '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 0x10d857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9eab20>, '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.n8QndI80IQ/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.915j0FKsJ8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 09:55:45 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 09:55:45 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 09:55:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n8QndI80IQ/Render', 09:55:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:45 INFO - 'HOME': '/Users/cltbld', 09:55:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:45 INFO - 'LOGNAME': 'cltbld', 09:55:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:45 INFO - 'MOZ_NO_REMOTE': '1', 09:55:45 INFO - 'NO_EM_RESTART': '1', 09:55:45 INFO - 'PAGER': '/bin/cat', 09:55:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:45 INFO - 'PWD': '/builds/slave/test', 09:55:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:45 INFO - 'SHELL': '/bin/bash', 09:55:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.915j0FKsJ8/Listeners', 09:55:45 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 09:55:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:45 INFO - 'USER': 'cltbld', 09:55:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:45 INFO - 'XPC_FLAGS': '0x0', 09:55:45 INFO - 'XPC_SERVICE_NAME': '0', 09:55:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:46 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)) 09:55:46 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)) 09:55:46 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)) 09:55:46 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)) 09:55:46 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)) 09:55:46 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)) 09:55:46 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)) 09:55:46 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)) 09:55:46 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)) 09:55:46 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)) 09:55:46 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)) 09:55:46 INFO - Cleaning up... 09:55:46 INFO - Return code: 0 09:55:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:55:46 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')]} 09:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:46 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')]} 09:55:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:46 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 0x10db4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db564c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd2a493560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f3d30>, '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 0x10d857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9eab20>, '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.n8QndI80IQ/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.915j0FKsJ8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 09:55:46 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 09:55:46 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 09:55:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n8QndI80IQ/Render', 09:55:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:46 INFO - 'HOME': '/Users/cltbld', 09:55:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:46 INFO - 'LOGNAME': 'cltbld', 09:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:46 INFO - 'MOZ_NO_REMOTE': '1', 09:55:46 INFO - 'NO_EM_RESTART': '1', 09:55:46 INFO - 'PAGER': '/bin/cat', 09:55:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:46 INFO - 'PWD': '/builds/slave/test', 09:55:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:46 INFO - 'SHELL': '/bin/bash', 09:55:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.915j0FKsJ8/Listeners', 09:55:46 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 09:55:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:46 INFO - 'USER': 'cltbld', 09:55:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:46 INFO - 'XPC_FLAGS': '0x0', 09:55:46 INFO - 'XPC_SERVICE_NAME': '0', 09:55:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:46 INFO - Downloading/unpacking jsonschema 09:55:46 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 09:55:46 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 09:55:46 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 09:55:46 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 09:55:46 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 09:55:46 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 09:55:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:55:48 INFO - Downloading/unpacking functools32 (from jsonschema) 09:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:49 INFO - Downloading functools32-3.2.3-2.tar.gz 09:55:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:55:49 INFO - warning: no files found matching '*.txt' 09:55:49 INFO - no previously-included directories found matching 'build' 09:55:49 INFO - no previously-included directories found matching 'dist' 09:55:49 INFO - no previously-included directories found matching '.git*' 09:55:49 INFO - Installing collected packages: jsonschema, functools32 09:55:49 INFO - Running setup.py install for functools32 09:55:49 INFO - warning: no files found matching '*.txt' 09:55:49 INFO - no previously-included directories found matching 'build' 09:55:49 INFO - no previously-included directories found matching 'dist' 09:55:49 INFO - no previously-included directories found matching '.git*' 09:55:49 INFO - Successfully installed jsonschema functools32 09:55:49 INFO - Cleaning up... 09:55:49 INFO - Return code: 0 09:55:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:55:49 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')]} 09:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:49 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')]} 09:55:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:49 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 0x10db4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db564c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd2a493560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9f3d30>, '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 0x10d857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9eab20>, '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.n8QndI80IQ/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.915j0FKsJ8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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 09:55:49 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 09:55:49 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 09:55:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n8QndI80IQ/Render', 09:55:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:49 INFO - 'HOME': '/Users/cltbld', 09:55:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:49 INFO - 'LOGNAME': 'cltbld', 09:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:49 INFO - 'MOZ_NO_REMOTE': '1', 09:55:49 INFO - 'NO_EM_RESTART': '1', 09:55:49 INFO - 'PAGER': '/bin/cat', 09:55:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:49 INFO - 'PWD': '/builds/slave/test', 09:55:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:49 INFO - 'SHELL': '/bin/bash', 09:55:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.915j0FKsJ8/Listeners', 09:55:49 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 09:55:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:49 INFO - 'USER': 'cltbld', 09:55:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:49 INFO - 'XPC_FLAGS': '0x0', 09:55:49 INFO - 'XPC_SERVICE_NAME': '0', 09:55:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:49 INFO - Downloading/unpacking flake8 09:55:49 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 09:55:49 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 09:55:49 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 09:55:49 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 09:55:49 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 09:55:49 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 09:55:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:55:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:55:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:55:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:55:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:55:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:55:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:55:53 INFO - no previously-included directories found matching 'docs/_build' 09:55:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:55:53 INFO - Running setup.py install for pep8 09:55:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:55:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:55:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:55:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:55:53 INFO - no previously-included directories found matching 'docs/_build' 09:55:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:55:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:55:53 INFO - Cleaning up... 09:55:53 INFO - Return code: 0 09:55:53 INFO - Running post-action listener: _resource_record_post_action 09:55:53 INFO - Running post-action listener: _start_resource_monitoring 09:55:53 INFO - Starting resource monitoring. 09:55:53 INFO - ##### 09:55:53 INFO - ##### Running install step. 09:55:53 INFO - ##### 09:55:53 INFO - Running pre-action listener: _resource_record_pre_action 09:55:53 INFO - Running main action method: install 09:55:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:55:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:55:54 INFO - Reading from file tmpfile_stdout 09:55:54 INFO - Detecting whether we're running mozinstall >=1.0... 09:55:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:55:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:55:54 INFO - Reading from file tmpfile_stdout 09:55:54 INFO - Output received: 09:55:54 INFO - Usage: mozinstall [options] installer 09:55:54 INFO - Options: 09:55:54 INFO - -h, --help show this help message and exit 09:55:54 INFO - -d DEST, --destination=DEST 09:55:54 INFO - Directory to install application into. [default: 09:55:54 INFO - "/builds/slave/test"] 09:55:54 INFO - --app=APP Application being installed. [default: firefox] 09:55:54 INFO - mkdir: /builds/slave/test/build/application 09:55:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:55:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 09:56:16 INFO - Reading from file tmpfile_stdout 09:56:16 INFO - Output received: 09:56:16 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:56:16 INFO - Running post-action listener: _resource_record_post_action 09:56:16 INFO - ##### 09:56:16 INFO - ##### Running run-tests step. 09:56:16 INFO - ##### 09:56:16 INFO - Running pre-action listener: _resource_record_pre_action 09:56:16 INFO - Running main action method: run_tests 09:56:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:56:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:56:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:56:16 INFO - 2016-04-27 09:56:16.732 screenresolution[1650:7711] starting screenresolution argv=screenresolution get 09:56:16 INFO - 2016-04-27 09:56:16.734 screenresolution[1650:7711] Display 0: 1600x1200x32@60 09:56:16 INFO - 2016-04-27 09:56:16.740 screenresolution[1651:7713] starting screenresolution argv=screenresolution list 09:56:16 INFO - Available Modes on Display 0 09:56:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:56:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:56:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:56:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:56:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:56:16 INFO - Intel Iris: 09:56:16 INFO - Chipset Model: Intel Iris 09:56:16 INFO - Type: GPU 09:56:16 INFO - Bus: Built-In 09:56:16 INFO - VRAM (Dynamic, Max): 1536 MB 09:56:16 INFO - Vendor: Intel (0x8086) 09:56:16 INFO - Device ID: 0x0a2e 09:56:16 INFO - Revision ID: 0x0009 09:56:16 INFO - Displays: 09:56:16 INFO - Display: 09:56:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:56:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:56:16 INFO - Display Serial Number: 1600x1200 60 09:56:16 INFO - Main Display: Yes 09:56:16 INFO - Mirror: Off 09:56:16 INFO - Online: Yes 09:56:16 INFO - Rotation: Supported 09:56:16 INFO - Return code: 0 09:56:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:56:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:56:16 INFO - Python 2.7.3 09:56:16 INFO - Return code: 0 09:56:16 INFO - grabbing minidump binary from tooltool 09:56:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:16 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 0x10d9f3d30>, '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 0x10d857db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9eab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:56:16 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 09:56:16 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 09:56:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:56:17 INFO - Return code: 0 09:56:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:56:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:56:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:56:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:56:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:56:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:56:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:56:18 INFO - Return code: 0 09:56:18 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/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0070', '--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 09:56:18 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/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0070 --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 09:56:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n8QndI80IQ/Render', 09:56:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:18 INFO - 'HOME': '/Users/cltbld', 09:56:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:18 INFO - 'LOGNAME': 'cltbld', 09:56:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:56:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:56:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:18 INFO - 'MOZ_NO_REMOTE': '1', 09:56:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:56:18 INFO - 'NO_EM_RESTART': '1', 09:56:18 INFO - 'PAGER': '/bin/cat', 09:56:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:18 INFO - 'PWD': '/builds/slave/test', 09:56:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:56:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:18 INFO - 'SHELL': '/bin/bash', 09:56:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.915j0FKsJ8/Listeners', 09:56:18 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 09:56:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:18 INFO - 'USER': 'cltbld', 09:56:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:18 INFO - 'XPC_FLAGS': '0x0', 09:56:18 INFO - 'XPC_SERVICE_NAME': '0', 09:56:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:18 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/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0070', '--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 09:56:18 INFO - mozversion application_buildid: 20160427075503 09:56:18 INFO - mozversion application_changeset: e0cddb21b2849605a49f8ace1b786e0dd04ef4ce 09:56:18 INFO - mozversion application_display_name: Firefox 09:56:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:56:18 INFO - mozversion application_name: Firefox 09:56:18 INFO - mozversion application_remotingname: firefox 09:56:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:56:18 INFO - mozversion application_vendor: Mozilla 09:56:18 INFO - mozversion application_version: 47.0 09:56:18 INFO - mozversion platform_buildid: 20160427075503 09:56:18 INFO - mozversion platform_changeset: e0cddb21b2849605a49f8ace1b786e0dd04ef4ce 09:56:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:56:18 INFO - mozversion platform_version: 47.0 09:56:18 INFO - using testdate: 1461776178 09:56:18 INFO - actual date: 1461776178 09:56:18 INFO - starting webserver on 'localhost:49285' 09:56:18 INFO - SUITE-START | Running 2 tests 09:56:18 INFO - TEST-START | dromaeo_css 09:56:18 INFO - operating with platform_type : mac_ 09:56:18 INFO - Initialising browser for dromaeo_css test... 09:56:18 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpNv3Xdy/profile http://localhost:49285/getInfo.html) 09:56:21 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 09:56:21 INFO - PROCESS | 1669 | colorDepth:24 09:56:21 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 09:56:21 INFO - PROCESS | 1669 | __metrics 09:56:21 ERROR - PROCESS | 1669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 09:56:22 INFO - TEST-INFO | 1669: exit 0 09:56:22 INFO - Browser initialized. 09:56:22 INFO - Running cycle 1/1 for dromaeo_css test... 09:56:22 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpNv3Xdy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:56:34 INFO - PROCESS | 1673 | RSS: Main: 167911424 09:56:34 INFO - PROCESS | 1673 | 09:57:23 INFO - PROCESS | 1673 | 1461776243638 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] 09:59:33 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49285/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49285/tests/dromaeo/cssquery-ext.html) 09:59:34 INFO - PROCESS | 1673 | RSS: Main: 184623104 09:59:34 INFO - PROCESS | 1673 | 10:02:36 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49285/tests/dromaeo/cssquery-ext.html (next: http://localhost:49285/tests/dromaeo/cssquery-jquery.html) 10:02:37 INFO - PROCESS | 1673 | RSS: Main: 194719744 10:02:37 INFO - PROCESS | 1673 | 10:05:38 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49285/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49285/tests/dromaeo/cssquery-mootools.html) 10:05:39 INFO - PROCESS | 1673 | RSS: Main: 196505600 10:05:39 INFO - PROCESS | 1673 | 10:08:41 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49285/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49285/tests/dromaeo/cssquery-prototype.html) 10:08:41 INFO - PROCESS | 1673 | RSS: Main: 200232960 10:08:41 INFO - PROCESS | 1673 | 10:11:44 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49285/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49285/tests/dromaeo/cssquery-yui.html) 10:11:44 INFO - PROCESS | 1673 | RSS: Main: 199299072 10:11:44 INFO - PROCESS | 1673 | 10:14:47 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49285/tests/dromaeo/cssquery-yui.html (next: http://localhost:49285/tests/dromaeo/cssquery-dojo.html) 10:14:47 INFO - PROCESS | 1673 | RSS: Main: 204857344 10:14:47 INFO - PROCESS | 1673 | 10:14:47 INFO - PROCESS | 1673 | __start_tp_report 10:14:47 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 10:14:47 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 10:14:47 INFO - PROCESS | 1673 | |i|pagename|runs| 10:14:47 INFO - PROCESS | 1673 | |0;dojo.html;2798.762105221056;3222.5649537312465;3613.9158252524235;3690.2435000824817;3699.963000369997;4566.543345665436;4875.75621218939;5935.406459354073;5971.5521335899875;6008.549358798085;5924.940750592493;5972;5976.133460648203;6029.7286622102;6055.969720151393;4340.43574335336;4968.801247950078;5397.487238712316;5400.78396864125;5479.232907392969;5357.49103835137;5381.7578208980685;5468.398476167638;5490.533304669108;5517.172424136372;5407.405185429599;5439.102548079562;5448.891022179554;5469.863253418656;5482.780688772445;4766.594839438651;5390.1375779875425;5450.591205659572;5504.119340905436;5511.3937466878615;5350.91973620396;5353.197020446925;5364;5367.892642147174;5374;4568.017876156642;5843.9707801461145;5882.117682347639;5882.617629854046;5931.228940237785;6211;6224.688765561704;6256.1866957295715;6271.937280627227;6309.4636955858805;6259.561830671855;6313.715882785285;6314.242290925073;6332.905006424908;6448.613083215022;6074.149619053292;6082.482988945945;6084.4828189603495;6105.236845394325;6112.786052488142;6327.96836015817;6398.9040164397575;6472;6516.641584712792;6551.246606640298;6270.122182894398;6295.496360291258;6310.148130002391;6319.6208227506495;6329.873402531924;6172.290186628506;6449.967750161313;6455.322191169954;6455.838604034937;6460.935390646127;6222.3466536013975;6236.469900058546;6285.465735412541;6294.087357333253;6330.936690633127;5167.9224811627855;6251.781187658501;6263.561550691408;6271.96864015677;6311.2426508819235;4221.6833737469815;4911.803527858846;4949.727764972961;5020.824271150492;5048.59611231108;3520.4543295789194;4419.049904270597;4503.166914120898;4569.337446070301;4597.908041839144;5878.412158784087;6051.9697401513595;6094.39056094387;6171.043488259327;6189.535784816157;6214.937850621526;6255.218097737783;6288.937110628926;6320.083587879732;6329.873402531924;6130.356312587203;6136.754529818757;6166.907496387557;6171.352008039181;6183.288921773964;5578.079616863172;5579;5599.524040456607;5605.271314729141;5611.158326251095;5499.890002200013;6373.298937116913;6459.160309159874;6505.414512693786;6554.377334153343;6282.8429289266305;6309.3690630936535;6315.5894866833505;6328.430441260124;6388.977763557994;6487.3188315226225;6504.1219435375615;6505.349465053457;6510.641914694737;6511.641859697762;6200.7519699211525;6210.689465526615;6241.344658810759;6267.091271765659;6282.623042617458;5456.48163424474;6079.6928660338235;6314.526410519321;6327.367263273636;6368.299487056513;6162.537809664203;6214;6258.718357673824;6319.58922670025;6346.9682651586445;6158.507319414346;6213.502919766317;6266.937330626635;6301.842453938688;6324.1146239527425;6190.81427557174;6242.781502647567;6259.655718935503;6266.216722909637;6295.5907865988565;6127.84680382994;6143.849652621547;6276.937230627818;6290.685465726787;6304.432601065926;6117.510599152146;6157.815265542041;6199;6254.2807577129215;6286.4342209201395 10:14:47 INFO - PROCESS | 1673 | |1;ext.html;469.17893686049416;590.4715279824558;621.4934828115086;622.7508996401436;688.6419062087715;39625;39997.20005599886;40361.79819100904;40434.59565404345;40615.39076913845;41984.95037624061;41985.7900710496;42268.78865605676;42631.78684106583;42785;9645.807083858335;9837.360571562862;9848.16290615295;9911.752206194831;9929.354591951536;9750.317477776558;9983.650572229973;10042.046005629454;10057.798844023115;10071.194304455663;9998.25013124015;10104.69685909424;10116.089551940324;10128.696139115802;10150.390976541394;9993.950030249838;10044.698659040241;10046.146077583415;10063.496825158712;10069.546870390814;9842.409455432697;9951.651692190739;9964.451955142464;9964.90386057533;10006.399616023062;34931;40261.19477610431;40367.596324036975;40655.59344406577;41118.177636447406;3141.6387115481784;3344.130526063241;3359.9920023992704;3404.3191361727504;3532.6114127445962;27599.72400276012;27624.309392265153;28607;28756.568651470243;29153.708462915525;2768.5431903735857;2769.4461107778525;2792.8882844686186;2862.957055644167;2969.4506516294555;350300;351236;354405;354679;355649.22175389214;48113.278300825514;48702.75648621805;48818.511814882106;66930.66534667296;68425;45703.77148114238;46243.537564624596;46410;46443;46503.069938601715;17386.391476298268;17550;17564.38524651631;17569.736453953203;17616.64766704659;13638.977076719286;13831.515896943558;13948.72102557943;13993.510227142002;14082.732554070182;12592;15067.09597424158;15213.467528636445;15316.387344506094;15535.145566993924;5200.427952925175;6125.142480052797;6407.647579383179;6498.935010649928;6524.608523488511;1002.2633364477103;1028.3469996552244;1137.1641843245209;1146.6674664347413;1165.3823473558857;31505.36989260202;31524.842375787975;31805;31920.840395797873;31975.360492790012;1090.432974853072;1152.4871432212753;1166.288563975974;1219;1307.457405176841;15268.16025118607;15567;16045.59886002836;16108.95291806029;16306.510804675878;544400.5559944429;545120;547942;550012;553722;62796;63178;63325.36674633287;63582;64131;1538.4538488836527;1561.156975233384;1580.6917651058163;1582.1298285942685;1587.317453494985;30064.549031764105;31096.067117985593;31149.065528034196;31172.532412013385;31310.37379252448;53898;53938;54400;54499.45500544944;54617;517011.4149429379;520550;520960;521556;521792;34026.809061682725;34617.134571635914;34735.47896781601;35134;35429;47992.520074798806;48106.03787924152;48200.03599927912;48245.55263342105;49038.971335133094;39433.211335773696;39880.800595996836;39937.600623993385;40437.393439099025;41515.58484415238;38562.614373855904;38848.6115138845;39150;39400.211995760495;39934.60065399309;39001.60998390093;39390.01524961784;39756.60243397645;40221.59778402178;40377.39433908553;31167.220819479695;33572.49641255432;33734.49398258979;33906.15234619154;34025.65974340225;25349.493010140064;25652;25705.742942570334;25759;25995.090171843894 10:14:47 INFO - PROCESS | 1673 | |2;jquery.html;348.51034296812986;359.96940260077895;379.07883842263305;379.2453018493198;380.2565983502253;20734;20868.68696969545;21054.89472552637;22268.220612278572;22295.442613934618;21575.35273941784;21978.670319945173;22280.554388912213;22486.66270005951;22510.32469025932;5295.258663787054;5912.438318359749;5939.554533410001;6178.598391104586;6211.9378806212035;5064.848054558369;5379.623426360156;6122.755089796403;6168.506519478454;6174.043023331391;5791.942080579203;6102.359252278514;6120.051392034219;6147.354527774586;6154.107654390111;6051.606645568024;6065.666388348639;6085.665288409135;6087.299960504554;6103.725332360033;5282.313299271109;5311.362636483608;5322.441143679896;5329.546988505982;5348.572114230891;25555.488890222277;25758.356041099123;26039.218823435327;26100.347491312677;26561.804718787702;2107.1360742095667;2377.690900182965;2615.5553555895544;2757.2831063923522;2762.0608992942293;8870.334724895658;10025.949870250675;10139.847902281472;10407.959204079607;13221.405036773369;1515.780211869284;1760.4982579964649;1834.6789311870368;1850.8519318454491;2030.187924830065;112008;116433.25350119756;118268;118945.40527297395;120318.39840800827;11562.132840037031;11617.941910290394;11670.416479176178;11694.064474841993;11815;12030.759384812254;14435.639109022359;14437.85562144365;14440.422383104768;14453.566393008226;8908.777280568038;8963.731088067369;9066.682666106786;9145.954270228607;9175.495347755937;9168.587413566405;9288.024757400512;9375.34372593912;9430.292728045286;9443.150116489549;4499.52754960731;4544.318352247124;4551.817927282872;4588.426446694163;4605.240135377625;1929.070929070929;1957.6965570336336;1975.259277770836;1983.107601579295;1995.920163193456;946.6592026870321;955.5843208204453;982.1995074014656;1010.4897027001317;1023.3961962442195;21274.93625318728;21530.354089377342;21603.919804010053;21815.563688726135;21929.890350548463;1008.7931973945324;1011.4639241202175;1062.198040479433;1070.1278458056659;1085.337943854264;11231.10151187903;11687.941560292315;11718.824217636742;11734.823977640342;11761.294322340687;560944.1952790292;666893;671003;676079;702121;83720.325593489;84968;94951.62620934533;123681.38159309146;125396.37301813615;1005.8742657167854;1087.635642059903;1094.43089593411;1105.3865104866877;1112.2436743014828;18533.907330463262;19107;19179.424617261506;19288.517787054876;19338;51663.45009649717;54209.72895135499;54627.18059229035;54934.52092684237;57717;70364.64817675878;70789.81024847446;71508.64245678738;72040.27959720546;73107.63446182734;7083.610401427971;8196.713115040944;8271.586420679063;8309.086000539815;8372.07907130203;9054.456732596065;13571.932140339235;13671.794923075962;13723;14118.50585229512;11653.067754579444;11756;12008.459619316976;12025.098117641386;12102.09234307448;10147.289689721943;11300.660980170607;11422.657320280405;11926.986206172225;11986.76026479483;11916.225445346025;11922.165448418527;12087.456064477296;12102.576409825613;12242.387880606113;8202.507849529047;8264.958675206586;8301.543415112226;8303.294219991127;8423.747287581382;9022.593983270637;11948.641540753444;12045.33750643723;12089.093318001009;12103.51585936588 10:14:47 INFO - PROCESS | 1673 | |3;mootools.html;1645.893016953898;1653.6692661467705;1998.5403357227838;2061.896905154743;2101.138533201388;8266.917330826689;8898.688545900879;9002.86495702565;9203.723888283354;9228.676996305123;8954.686585969492;8971.820563588724;9032.548372581377;9071.274298056156;9086.409383390075;2574.806889483287;2595.7144714081437;2601.6877974642975;2602.128287023849;2609.425926296212;2538.708048574419;2596.0654164500766;2600.947981040378;2602.4925139597785;2607.517609242296;2566.2044766122563;2588.637590737298;2590.3783092057865;2600.1159605734047;2609.438970621316;2326.255598208574;2466.4820387718423;2567.717551069381;2575.5621544337414;2604.0495219245026;2291.8166546676225;2577.768000879911;2595.1176599956107;2609.5302845487804;2616.123598594473;8832.470051796912;9171.174594286545;9199.816003679889;9202.263818894473;9206;5605.467480589378;5687.886242275173;5715.142728590745;5747.741351639186;5772.711364431803;3723.255348930225;3734.7572407793405;3814.0083578269573;3885.30064588374;3892.610738926113;1067.7063807452935;1076.6716151573767;1081.8701755789277;1123.230587047875;1126.6676330482528;12263.957563607104;12348.320842353667;12420.56528021524;12483.625491235278;12564.994800415945;4322.978385108055;4993.775280112403;5028.296038554606;5075.3402057733;5164.845054648366;10552.525136368728;10609.15126789855;10624;10647.893521064845;10687.625933092304;5777.884442311214;5788.797392091341;5835.44563266489;5843.444872737083;5880.411958804086;4677.4387073550715;5086.18621020635;5156.793728250828;5219.973900130551;5292.603054770908;4031.0092714193447;4088.161926805057;4098.569650186688;4103.528094269138;4105.2405305018665;1365.6449323176046;1381.6891199480037;1385.3073463268365;1385.810419537149;1386.1336664584635;1417.893657975656;1440.3446431873472;1444.992775036118;1447.1895738386538;1460.6713489464785;8485;8498.617562209716;8532.146785321542;8538.70114545988;8577;532.2456288705931;539.5548672345252;544.3386285662939;545.1903922674825;546.7047794191171;6291.653959032297;6355.142055822497;6380.106785050097;6415.775447859302;6535.967320163369;10820.78358432827;11228.943855280835;11237.887621123848;11252.030894593414;11409.771804563863;10711.25021248505;10920.2901811382;11023.283486573508;11038.11695064393;11112.333260004425;8713.259372953244;8747.08155643661;8760.605772740242;8792.78018049541;8794;8093.716719914774;8193.057798353266;8208.097109318089;8247.752567422987;8278.875816862632;9492.460077621945;9670.468124253233;9987.550560224952;10061.144802691853;10378.169746420117;7114.466415018997;9865.408075515492;10025.248106391904;10106.545205465625;10315.020073093045;8249.216324449168;8383.077861435358;8444.240018398374;8463.111373305714;8542;7048.929510705032;8349.290310323691;8381.078081410918;8412.242898138951;8460.323174146177;7562.584057876869;7657.310842024244;7675.53946763196;7834.843303134019;7868.803279918048;7511.248875112664;7551.73568925085;7613.08642962848;7667.808304792425;7691.384689224737;8048.718294859652;8152.347812174893;8190.180981901762;8191;8208.794780130305;7242.96378518104;7364.521306115085;7373.8156546086775;7374.889376659247;7390.224026477143;7440;7452;7472.514286571355;7493.40052795786;7502.212267711811 10:14:47 INFO - PROCESS | 1673 | |4;prototype.html;342.7720565823727;344.6777263258853;347.7270342780916;348.8848679935621;351.64308227149445;6867.9698045293235;6886.449084073274;6905.861882762354;6908.17101947767;6912.066870972417;6786.016027675984;6787.694553745081;6796.796096117112;6844.041834143211;6913.239543650207;4892.877678058059;4978.576820970222;5093.949060509403;5099.796008159669;5150.587952963763;3883.572806991229;4121.979390103045;5116.1302578561545;5134.974325128369;5182.238039066717;5076.974615126919;5099.821506247282;5105;5121.487851214886;5123.769430375642;5099.235114732783;5126.692398456067;5133.460986596409;5133.537981581639;5133.82031628893;3846.826717851054;4187.602177793105;4407.779611019436;4414.984553552701;4424.181526417623;6325.272593651743;6633.071370008202;6649.767258145942;6668.799936001879;6677.399034086907;5893.882122357529;5927.407259274038;5954.136650185742;5966.582339236255;5983.910241346383;6430.6174172552655;6920.446364290845;7411.147718012389;7413.258674132598;7431.108267007994;4761.381020467352;4772.188727916227;4777;4784.64115191362;4799.520047995173;7707.96146019272;7780.2219778021745;7796.649150788171;7798.337141342936;7817.765467035942;4619.2609182531305;4773.236282194832;4779.713217206979;4789.185838407479;4796.25658023007;4803.759812009385;4855.975720121377;4873.31773551703;4875.902481950341;4883.951160488421;5771.567132465082;5837.211976383134;5890.911636325459;5918.970405147947;5926.170336152942;7436.739714110088;7448.292412220831;7454.329110379983;7462.738804141829;7470.775876723707;1685.3342929543007;1711.247051297425;1712.4862541237578;1713.3831820544594;1714.2457318779698;1052.1162223732101;1084.430673896195;1103.6688993301977;1104.0780947908427;1105.8783533811275;5450.964316779799;5840.269966254218;6201.441870231701;6879.862402751917;6938.826529336807;7371.88942165868;7577.5453472790705;7581.12817026038;7676.270754278335;7684.884726729104;6871.4502839772695;7126.109236345457;7129.14450265961;7167.247439018828;7172.856542869218;3957.6939609928654;4090.836366545305;4097.651699605507;4099.9180016400105;4104.0970986382945;7222.422206223595;7327.926720732831;8055.355571554262;8099.311558517592;8138.470999385021;7661.61691915402;7934.642941067666;7973.20267973198;7978.521288722695;7990.200979901963;7209.954556589265;8040.15578364275;8065.879011814827;8076.111627720946;8086.797830054295;7066.611336376549;7701.1913749057785;7705.190954949874;7708.190639982721;7746.535207887319;7565.697372105275;7566.24337566239;7577;7577.355924746458;7605.163432022362;5698.888716700204;7453.962730186315;7731.33776238089;7946.64240109208;8077.636506357346;4823.27650852375;4840.709557426566;4874.317595536699;4882.998985208095;4894.314795928644;6229.781957631461;7700.537967721954;7715.112762032214;7723.575203363869;7760.262775036363;7313.853722925618;7380.483366164317;7407.222241664547;7455.92544074574;7458.105027396748;6091.390860914051;7197.604131772593;7405.111386633638;7437.702491900263;7444;7250.057492525938;7286.781396558112;7287.599182045038;7300.379467745089;7316.561006339637;7408.222136675787;7417.406607471282;7441.144268409203;7446.962765186139;7451.701931922879;7039.084918960502;7262.782116536512;7279.344858962719;7301.963490182515;7323.63381830917 10:14:47 INFO - PROCESS | 1673 | |5;yui.html;749.142232144195;752.6688257166846;764.0334976255036;768.7693691892431;794.4994653368377;15382.153981531012;15653.686926261482;15667.29497172627;15689.92155039226;15776.921115394407;14527.273636318168;14590.41638334468;14594.489192878225;14602.561923142297;14604.415823367053;796.7330944133722;963;990.173205373514;1015.6343716262139;1020.7754294055296;967.1440774914181;977.3402953006728;977.5405559387077;991.2466525440645;993.7813680990207;1054.051353781595;1063.9148868090572;1068.1294744783015;1068.593934304963;1069.3530414099475;1049.8687664041995;1053.515382923856;1057.1225882517492;1058.8729352477712;1059.6450189186633;778.1557010643459;784.3646646216525;787.263908245792;790.3400660448532;795.9930687680089;12630.873691263061;15365.078095314317;15509.767353489706;15574.14342211178;15607.063576185465;11609.955104040677;12937.676558086028;12986.545470908568;13169.144005639699;13317.334133293296;9605.135537801561;9755.951220243924;9791.216702663769;9933.25500587459;10143.543540540619;3576.7138628909624;3580.8030558319283;3618.2582570572968;3709.350863598859;3886.7862267575274;77793;79947.60026199832;81972.59013704893;82032;82359;9861;9885.75285617851;10001.949990250148;10059.446730429896;10105.040021197974;22099.33701988943;22471.213507527485;22510.32469025932;22674.546509069725;22698.205562805222;7648.464607477423;7819.765407037798;7920.643571039317;7939.28546430824;8138.470999385021;4208.558101399371;4275.935860962088;4291.871243862689;4297.871063868089;4414.977925110354;3679.2641471705765;3691.298653255873;3719.8326075326677;3725.925481490355;3751.8311675974646;664.9858965078295;689.0628744906923;689.162667359151;689.1798759476208;691.1740470138137;605.3190161068798;609.7957184343295;613.9324674285825;619.485826763785;621.4841681404423;7900.814877768265;8544.700935467228;8568.314534837198;8719.60761765722;8730.69442569507;588.5997521685209;601.9646208521336;603.7072020070262;607.1753490763783;611.403881215811;3923.1761330120426;4002.399640053957;4024.1549274652652;4035.435039094529;4216.262154123016;71242.28757712357;93940.06059939312;93950.53024734833;94046;94369;62268.68865655643;75166.36917707854;82514;82673;83183.58408207921;55898;70116;73044.63477682577;73528.89706654404;74584;8566.700165494178;8576.957115214384;8639.265662418766;8722;8745.737627871174;37130.6286937138;47883;47923.04153916833;52109.7394513025;53105.20342194793;73365;73392.63303683448;73503.26496734965;73565.26434735584;73903.63048184724;9863.556139973862;10778;11338.376389298668;11605.284904965356;11698.649040528799;12294.692632684255;12329.753404932031;12446.751064978831;12773.169743966613;12935.935320323339;11957.581484648343;11995.880041199476;12037.638870833889;12131.636050918487;12161.69595760113;11799.17405781587;11856.70358241051;12056.156069075432;12140.271583705005;12266.141370104364;11644.708882278012;11731.634743342482;11761.235519691192;11767.941160294144;11893.167478276784;9932;9950.55222514974;10170.186385089028;10171.186305095722;10211.948940255252;8267.958660206661;10046.799064018825;10142.442165680959;10233.437160956219;10242 10:14:47 INFO - PROCESS | 1673 | __end_tp_report 10:14:47 INFO - PROCESS | 1673 | __start_cc_report 10:14:47 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,352 10:14:47 INFO - PROCESS | 1673 | __end_cc_report 10:14:47 INFO - PROCESS | 1673 | __startTimestamp1461777287294__endTimestamp 10:14:47 INFO - PROCESS | 1673 | 10:14:47 INFO - PROCESS | 1673 | ------- Summary: start ------- 10:14:47 INFO - PROCESS | 1673 | Number of tests: 6 10:14:47 INFO - PROCESS | 1673 | 10:14:47 INFO - PROCESS | 1673 | [#0] dojo.html Cycles:165 Average:5856.61 Median:6171.35 stddev:710.39 (11.5%) stddev-sans-first:670.85 10:14:47 INFO - PROCESS | 1673 | Values: 2798.8 3222.6 3613.9 3690.2 3700.0 4566.5 4875.8 5935.4 5971.6 6008.5 5924.9 5972.0 5976.1 6029.7 6056.0 4340.4 4968.8 5397.5 5400.8 5479.2 5357.5 5381.8 5468.4 5490.5 5517.2 5407.4 5439.1 5448.9 5469.9 5482.8 4766.6 5390.1 5450.6 5504.1 5511.4 5350.9 5353.2 5364.0 5367.9 5374.0 4568.0 5844.0 5882.1 5882.6 5931.2 6211.0 6224.7 6256.2 6271.9 6309.5 6259.6 6313.7 6314.2 6332.9 6448.6 6074.1 6082.5 6084.5 6105.2 6112.8 6328.0 6398.9 6472.0 6516.6 6551.2 6270.1 6295.5 6310.1 6319.6 6329.9 6172.3 6450.0 6455.3 6455.8 6460.9 6222.3 6236.5 6285.5 6294.1 6330.9 5167.9 6251.8 6263.6 6272.0 6311.2 4221.7 4911.8 4949.7 5020.8 5048.6 3520.5 4419.0 4503.2 4569.3 4597.9 5878.4 6052.0 6094.4 6171.0 6189.5 6214.9 6255.2 6288.9 6320.1 6329.9 6130.4 6136.8 6166.9 6171.4 6183.3 5578.1 5579.0 5599.5 5605.3 5611.2 5499.9 6373.3 6459.2 6505.4 6554.4 6282.8 6309.4 6315.6 6328.4 6389.0 6487.3 6504.1 6505.3 6510.6 6511.6 6200.8 6210.7 6241.3 6267.1 6282.6 5456.5 6079.7 6314.5 6327.4 6368.3 6162.5 6214.0 6258.7 6319.6 6347.0 6158.5 6213.5 6266.9 6301.8 6324.1 6190.8 6242.8 6259.7 6266.2 6295.6 6127.8 6143.8 6276.9 6290.7 6304.4 6117.5 6157.8 6199.0 6254.3 6286.4 10:14:47 INFO - PROCESS | 1673 | 10:14:47 INFO - PROCESS | 1673 | [#1] ext.html Cycles:180 Average:62362.28 Median:354542.00 stddev:128140.12 (36.1%) stddev-sans-first:128415.33 10:14:47 INFO - PROCESS | 1673 | Values: 469.2 590.5 621.5 622.8 688.6 39625.0 39997.2 40361.8 40434.6 40615.4 41985.0 41985.8 42268.8 42631.8 42785.0 9645.8 9837.4 9848.2 9911.8 9929.4 9750.3 9983.7 10042.0 10057.8 10071.2 9998.3 10104.7 10116.1 10128.7 10150.4 9994.0 10044.7 10046.1 10063.5 10069.5 9842.4 9951.7 9964.5 9964.9 10006.4 34931.0 40261.2 40367.6 40655.6 41118.2 3141.6 3344.1 3360.0 3404.3 3532.6 27599.7 27624.3 28607.0 28756.6 29153.7 2768.5 2769.4 2792.9 2863.0 2969.5 350300.0 351236.0 354405.0 354679.0 355649.2 48113.3 48702.8 48818.5 66930.7 68425.0 45703.8 46243.5 46410.0 46443.0 46503.1 17386.4 17550.0 17564.4 17569.7 17616.6 13639.0 13831.5 13948.7 13993.5 14082.7 12592.0 15067.1 15213.5 15316.4 15535.1 5200.4 6125.1 6407.6 6498.9 6524.6 1002.3 1028.3 1137.2 1146.7 1165.4 31505.4 31524.8 31805.0 31920.8 31975.4 1090.4 1152.5 1166.3 1219.0 1307.5 15268.2 15567.0 16045.6 16109.0 16306.5 544400.6 545120.0 547942.0 550012.0 553722.0 62796.0 63178.0 63325.4 63582.0 64131.0 1538.5 1561.2 1580.7 1582.1 1587.3 30064.5 31096.1 31149.1 31172.5 31310.4 53898.0 53938.0 54400.0 54499.5 54617.0 517011.4 520550.0 520960.0 521556.0 521792.0 34026.8 34617.1 34735.5 35134.0 35429.0 47992.5 48106.0 48200.0 48245.6 49039.0 39433.2 39880.8 39937.6 40437.4 41515.6 38562.6 38848.6 39150.0 39400.2 39934.6 39001.6 39390.0 39756.6 40221.6 40377.4 31167.2 33572.5 33734.5 33906.2 34025.7 25349.5 25652.0 25705.7 25759.0 25995.1 10:14:47 INFO - PROCESS | 1673 | 10:14:47 INFO - PROCESS | 1673 | [#2] jquery.html Cycles:180 Average:36035.37 Median:22498.49 stddev:108592.99 (482.7%) stddev-sans-first:108864.56 10:14:47 INFO - PROCESS | 1673 | Values: 348.5 360.0 379.1 379.2 380.3 20734.0 20868.7 21054.9 22268.2 22295.4 21575.4 21978.7 22280.6 22486.7 22510.3 5295.3 5912.4 5939.6 6178.6 6211.9 5064.8 5379.6 6122.8 6168.5 6174.0 5791.9 6102.4 6120.1 6147.4 6154.1 6051.6 6065.7 6085.7 6087.3 6103.7 5282.3 5311.4 5322.4 5329.5 5348.6 25555.5 25758.4 26039.2 26100.3 26561.8 2107.1 2377.7 2615.6 2757.3 2762.1 8870.3 10025.9 10139.8 10408.0 13221.4 1515.8 1760.5 1834.7 1850.9 2030.2 112008.0 116433.3 118268.0 118945.4 120318.4 11562.1 11617.9 11670.4 11694.1 11815.0 12030.8 14435.6 14437.9 14440.4 14453.6 8908.8 8963.7 9066.7 9146.0 9175.5 9168.6 9288.0 9375.3 9430.3 9443.2 4499.5 4544.3 4551.8 4588.4 4605.2 1929.1 1957.7 1975.3 1983.1 1995.9 946.7 955.6 982.2 1010.5 1023.4 21274.9 21530.4 21603.9 21815.6 21929.9 1008.8 1011.5 1062.2 1070.1 1085.3 11231.1 11687.9 11718.8 11734.8 11761.3 560944.2 666893.0 671003.0 676079.0 702121.0 83720.3 84968.0 94951.6 123681.4 125396.4 1005.9 1087.6 1094.4 1105.4 1112.2 18533.9 19107.0 19179.4 19288.5 19338.0 51663.5 54209.7 54627.2 54934.5 57717.0 70364.6 70789.8 71508.6 72040.3 73107.6 7083.6 8196.7 8271.6 8309.1 8372.1 9054.5 13571.9 13671.8 13723.0 14118.5 11653.1 11756.0 12008.5 12025.1 12102.1 10147.3 11300.7 11422.7 11927.0 11986.8 11916.2 11922.2 12087.5 12102.6 12242.4 8202.5 8265.0 8301.5 8303.3 8423.7 9022.6 11948.6 12045.3 12089.1 12103.5 10:14:47 INFO - PROCESS | 1673 | 10:14:47 INFO - PROCESS | 1673 | [#3] mootools.html Cycles:180 Average:6305.74 Median:535.90 stddev:3317.33 (619.0%) stddev-sans-first:3308.15 10:14:47 INFO - PROCESS | 1673 | Values: 1645.9 1653.7 1998.5 2061.9 2101.1 8266.9 8898.7 9002.9 9203.7 9228.7 8954.7 8971.8 9032.5 9071.3 9086.4 2574.8 2595.7 2601.7 2602.1 2609.4 2538.7 2596.1 2600.9 2602.5 2607.5 2566.2 2588.6 2590.4 2600.1 2609.4 2326.3 2466.5 2567.7 2575.6 2604.0 2291.8 2577.8 2595.1 2609.5 2616.1 8832.5 9171.2 9199.8 9202.3 9206.0 5605.5 5687.9 5715.1 5747.7 5772.7 3723.3 3734.8 3814.0 3885.3 3892.6 1067.7 1076.7 1081.9 1123.2 1126.7 12264.0 12348.3 12420.6 12483.6 12565.0 4323.0 4993.8 5028.3 5075.3 5164.8 10552.5 10609.2 10624.0 10647.9 10687.6 5777.9 5788.8 5835.4 5843.4 5880.4 4677.4 5086.2 5156.8 5220.0 5292.6 4031.0 4088.2 4098.6 4103.5 4105.2 1365.6 1381.7 1385.3 1385.8 1386.1 1417.9 1440.3 1445.0 1447.2 1460.7 8485.0 8498.6 8532.1 8538.7 8577.0 532.2 539.6 544.3 545.2 546.7 6291.7 6355.1 6380.1 6415.8 6536.0 10820.8 11228.9 11237.9 11252.0 11409.8 10711.3 10920.3 11023.3 11038.1 11112.3 8713.3 8747.1 8760.6 8792.8 8794.0 8093.7 8193.1 8208.1 8247.8 8278.9 9492.5 9670.5 9987.6 10061.1 10378.2 7114.5 9865.4 10025.2 10106.5 10315.0 8249.2 8383.1 8444.2 8463.1 8542.0 7048.9 8349.3 8381.1 8412.2 8460.3 7562.6 7657.3 7675.5 7834.8 7868.8 7511.2 7551.7 7613.1 7667.8 7691.4 8048.7 8152.3 8190.2 8191.0 8208.8 7243.0 7364.5 7373.8 7374.9 7390.2 7440.0 7452.0 7472.5 7493.4 7502.2 10:14:47 INFO - PROCESS | 1673 | 10:14:47 INFO - PROCESS | 1673 | [#4] prototype.html Cycles:180 Average:6003.50 Median:6856.01 stddev:1932.67 (28.2%) stddev-sans-first:1890.82 10:14:47 INFO - PROCESS | 1673 | Values: 342.8 344.7 347.7 348.9 351.6 6868.0 6886.4 6905.9 6908.2 6912.1 6786.0 6787.7 6796.8 6844.0 6913.2 4892.9 4978.6 5093.9 5099.8 5150.6 3883.6 4122.0 5116.1 5135.0 5182.2 5077.0 5099.8 5105.0 5121.5 5123.8 5099.2 5126.7 5133.5 5133.5 5133.8 3846.8 4187.6 4407.8 4415.0 4424.2 6325.3 6633.1 6649.8 6668.8 6677.4 5893.9 5927.4 5954.1 5966.6 5983.9 6430.6 6920.4 7411.1 7413.3 7431.1 4761.4 4772.2 4777.0 4784.6 4799.5 7708.0 7780.2 7796.6 7798.3 7817.8 4619.3 4773.2 4779.7 4789.2 4796.3 4803.8 4856.0 4873.3 4875.9 4884.0 5771.6 5837.2 5890.9 5919.0 5926.2 7436.7 7448.3 7454.3 7462.7 7470.8 1685.3 1711.2 1712.5 1713.4 1714.2 1052.1 1084.4 1103.7 1104.1 1105.9 5451.0 5840.3 6201.4 6879.9 6938.8 7371.9 7577.5 7581.1 7676.3 7684.9 6871.5 7126.1 7129.1 7167.2 7172.9 3957.7 4090.8 4097.7 4099.9 4104.1 7222.4 7327.9 8055.4 8099.3 8138.5 7661.6 7934.6 7973.2 7978.5 7990.2 7210.0 8040.2 8065.9 8076.1 8086.8 7066.6 7701.2 7705.2 7708.2 7746.5 7565.7 7566.2 7577.0 7577.4 7605.2 5698.9 7454.0 7731.3 7946.6 8077.6 4823.3 4840.7 4874.3 4883.0 4894.3 6229.8 7700.5 7715.1 7723.6 7760.3 7313.9 7380.5 7407.2 7455.9 7458.1 6091.4 7197.6 7405.1 7437.7 7444.0 7250.1 7286.8 7287.6 7300.4 7316.6 7408.2 7417.4 7441.1 7447.0 7451.7 7039.1 7262.8 7279.3 7302.0 7323.6 10:14:47 INFO - PROCESS | 1673 | 10:14:47 INFO - PROCESS | 1673 | [#5] yui.html Cycles:180 Average:18499.54 Median:4294.87 stddev:25697.15 (598.3%) stddev-sans-first:25734.67 10:14:47 INFO - PROCESS | 1673 | Values: 749.1 752.7 764.0 768.8 794.5 15382.2 15653.7 15667.3 15689.9 15776.9 14527.3 14590.4 14594.5 14602.6 14604.4 796.7 963.0 990.2 1015.6 1020.8 967.1 977.3 977.5 991.2 993.8 1054.1 1063.9 1068.1 1068.6 1069.4 1049.9 1053.5 1057.1 1058.9 1059.6 778.2 784.4 787.3 790.3 796.0 12630.9 15365.1 15509.8 15574.1 15607.1 11610.0 12937.7 12986.5 13169.1 13317.3 9605.1 9756.0 9791.2 9933.3 10143.5 3576.7 3580.8 3618.3 3709.4 3886.8 77793.0 79947.6 81972.6 82032.0 82359.0 9861.0 9885.8 10001.9 10059.4 10105.0 22099.3 22471.2 22510.3 22674.5 22698.2 7648.5 7819.8 7920.6 7939.3 8138.5 4208.6 4275.9 4291.9 4297.9 4415.0 3679.3 3691.3 3719.8 3725.9 3751.8 665.0 689.1 689.2 689.2 691.2 605.3 609.8 613.9 619.5 621.5 7900.8 8544.7 8568.3 8719.6 8730.7 588.6 602.0 603.7 607.2 611.4 3923.2 4002.4 4024.2 4035.4 4216.3 71242.3 93940.1 93950.5 94046.0 94369.0 62268.7 75166.4 82514.0 82673.0 83183.6 55898.0 70116.0 73044.6 73528.9 74584.0 8566.7 8577.0 8639.3 8722.0 8745.7 37130.6 47883.0 47923.0 52109.7 53105.2 73365.0 73392.6 73503.3 73565.3 73903.6 9863.6 10778.0 11338.4 11605.3 11698.6 12294.7 12329.8 12446.8 12773.2 12935.9 11957.6 11995.9 12037.6 12131.6 12161.7 11799.2 11856.7 12056.2 12140.3 12266.1 11644.7 11731.6 11761.2 11767.9 11893.2 9932.0 9950.6 10170.2 10171.2 10211.9 8268.0 10046.8 10142.4 10233.4 10242.0 10:14:47 INFO - PROCESS | 1673 | -------- Summary: end -------- 10:14:47 INFO - PROCESS | 1673 | 10:14:47 INFO - TEST-INFO | 1673: exit 0 10:14:47 INFO - TEST-OK | dromaeo_css | took 1109305ms 10:14:47 INFO - TEST-START | kraken 10:14:47 INFO - operating with platform_type : mac_ 10:14:47 INFO - Initialising browser for kraken test... 10:14:47 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpVwL_ZY/profile http://localhost:49285/getInfo.html) 10:14:50 INFO - PROCESS | 1682 | __metrics Screen width/height:1600/1200 10:14:50 INFO - PROCESS | 1682 | colorDepth:24 10:14:50 INFO - PROCESS | 1682 | Browser inner width/height: 1024/689 10:14:50 INFO - PROCESS | 1682 | __metrics 10:14:50 ERROR - PROCESS | 1682 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 10:14:50 INFO - TEST-INFO | 1682: exit 0 10:14:50 INFO - Browser initialized. 10:14:50 INFO - Running cycle 1/1 for kraken test... 10:14:50 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpVwL_ZY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:15:02 INFO - PROCESS | 1686 | RSS: Main: 167993344 10:15:02 INFO - PROCESS | 1686 | 10:15:05 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49285/tests/kraken/driver.html?testName=audio-beat-detection) 10:15:06 INFO - PROCESS | 1686 | RSS: Main: 180260864 10:15:06 INFO - PROCESS | 1686 | 10:15:08 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49285/tests/kraken/driver.html?testName=audio-dft) 10:15:09 INFO - PROCESS | 1686 | RSS: Main: 188850176 10:15:09 INFO - PROCESS | 1686 | 10:15:12 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49285/tests/kraken/driver.html?testName=audio-fft) 10:15:13 INFO - PROCESS | 1686 | RSS: Main: 192876544 10:15:13 INFO - PROCESS | 1686 | 10:15:15 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49285/tests/kraken/driver.html?testName=audio-oscillator) 10:15:16 INFO - PROCESS | 1686 | RSS: Main: 194543616 10:15:16 INFO - PROCESS | 1686 | 10:15:18 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49285/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:15:18 INFO - PROCESS | 1686 | RSS: Main: 194445312 10:15:18 INFO - PROCESS | 1686 | 10:15:21 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49285/tests/kraken/driver.html?testName=imaging-darkroom) 10:15:22 INFO - PROCESS | 1686 | RSS: Main: 195461120 10:15:22 INFO - PROCESS | 1686 | 10:15:25 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49285/tests/kraken/driver.html?testName=imaging-desaturate) 10:15:25 INFO - PROCESS | 1686 | RSS: Main: 195129344 10:15:25 INFO - PROCESS | 1686 | 10:15:28 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49285/tests/kraken/driver.html?testName=json-parse-financial) 10:15:29 INFO - PROCESS | 1686 | RSS: Main: 195239936 10:15:29 INFO - PROCESS | 1686 | 10:15:30 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49285/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:15:31 INFO - PROCESS | 1686 | RSS: Main: 194367488 10:15:31 INFO - PROCESS | 1686 | 10:15:33 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:15:34 INFO - PROCESS | 1686 | RSS: Main: 194523136 10:15:34 INFO - PROCESS | 1686 | 10:15:36 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:15:36 INFO - PROCESS | 1686 | RSS: Main: 194928640 10:15:36 INFO - PROCESS | 1686 | 10:15:39 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:15:39 INFO - PROCESS | 1686 | RSS: Main: 195112960 10:15:39 INFO - PROCESS | 1686 | 10:15:42 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:15:43 INFO - PROCESS | 1686 | RSS: Main: 195416064 10:15:43 INFO - PROCESS | 1686 | 10:15:44 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49285/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49285/tests/kraken/driver.html?testName=ai-astar) 10:15:45 INFO - PROCESS | 1686 | RSS: Main: 196603904 10:15:45 INFO - PROCESS | 1686 | 10:15:45 INFO - PROCESS | 1686 | __start_tp_report 10:15:45 INFO - PROCESS | 1686 | _x_x_mozilla_page_load 10:15:45 INFO - PROCESS | 1686 | _x_x_mozilla_page_load_details 10:15:45 INFO - PROCESS | 1686 | |i|pagename|runs| 10:15:45 INFO - PROCESS | 1686 | |0;ai-astar;117;114;116;116;117;128;115;114;115;117 10:15:45 INFO - PROCESS | 1686 | |1;audio-beat-detection;167;146;131;147;135;173;171;153;187;155 10:15:45 INFO - PROCESS | 1686 | |2;audio-dft;196;195;201;248;202;245;246;218;221;184 10:15:45 INFO - PROCESS | 1686 | |3;audio-fft;85;79;67;108;54;57;67;88;170;59 10:15:45 INFO - PROCESS | 1686 | |4;audio-oscillator;82;90;119;77;80;81;120;79;80;121 10:15:45 INFO - PROCESS | 1686 | |5;imaging-gaussian-blur;90;99;90;87;134;131;95;88;135;87 10:15:45 INFO - PROCESS | 1686 | |6;imaging-darkroom;95;95;103;97;103;151;151;96;96;96 10:15:45 INFO - PROCESS | 1686 | |7;imaging-desaturate;114;95;92;92;122;93;150;141;120;94 10:15:45 INFO - PROCESS | 1686 | |8;json-parse-financial;56;60;57;60;60;61;57;65;56;55 10:15:45 INFO - PROCESS | 1686 | |9;json-stringify-tinderbox;66;95;101;68;78;86;70;65;67;66 10:15:45 INFO - PROCESS | 1686 | |10;stanford-crypto-aes;83;84;81;83;83;83;84;84;82;89 10:15:45 INFO - PROCESS | 1686 | |11;stanford-crypto-ccm;134;135;113;134;134;131;139;121;119;124 10:15:45 INFO - PROCESS | 1686 | |12;stanford-crypto-pbkdf2;136;150;176;163;136;139;119;148;172;174 10:15:45 INFO - PROCESS | 1686 | |13;stanford-crypto-sha256-iterative;67;65;68;68;66;66;82;58;68;98 10:15:45 INFO - PROCESS | 1686 | __end_tp_report 10:15:45 INFO - PROCESS | 1686 | __start_cc_report 10:15:45 INFO - PROCESS | 1686 | _x_x_mozilla_cycle_collect,900 10:15:45 INFO - PROCESS | 1686 | __end_cc_report 10:15:45 INFO - PROCESS | 1686 | __startTimestamp1461777345077__endTimestamp 10:15:45 INFO - PROCESS | 1686 | 10:15:45 INFO - PROCESS | 1686 | ------- Summary: start ------- 10:15:45 INFO - PROCESS | 1686 | Number of tests: 14 10:15:45 INFO - PROCESS | 1686 | 10:15:45 INFO - PROCESS | 1686 | [#0] ai-astar Cycles:10 Average:116.90 Median:116.50 stddev:4.07 (3.5%) stddev-sans-first:4.31 10:15:45 INFO - PROCESS | 1686 | Values: 117.0 114.0 116.0 116.0 117.0 128.0 115.0 114.0 115.0 117.0 10:15:45 INFO - PROCESS | 1686 | 10:15:45 INFO - PROCESS | 1686 | [#1] audio-beat-detection Cycles:10 Average:156.50 Median:161.00 stddev:17.80 (11.1%) stddev-sans-first:18.47 10:15:45 INFO - PROCESS | 1686 | Values: 167.0 146.0 131.0 147.0 135.0 173.0 171.0 153.0 187.0 155.0 10:15:45 INFO - PROCESS | 1686 | 10:15:45 INFO - PROCESS | 1686 | [#2] audio-dft Cycles:10 Average:215.60 Median:219.50 stddev:23.75 (10.8%) stddev-sans-first:24.11 10:15:45 INFO - PROCESS | 1686 | Values: 196.0 195.0 201.0 248.0 202.0 245.0 246.0 218.0 221.0 184.0 10:15:45 INFO - PROCESS | 1686 | 10:15:45 INFO - PROCESS | 1686 | [#3] audio-fft Cycles:10 Average:83.40 Median:67.00 stddev:34.71 (51.8%) stddev-sans-first:36.81 10:15:45 INFO - PROCESS | 1686 | Values: 85.0 79.0 67.0 108.0 54.0 57.0 67.0 88.0 170.0 59.0 10:15:45 INFO - PROCESS | 1686 | 10:15:45 INFO - PROCESS | 1686 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:80.00 stddev:19.01 (23.8%) stddev-sans-first:19.75 10:15:45 INFO - PROCESS | 1686 | Values: 82.0 90.0 119.0 77.0 80.0 81.0 120.0 79.0 80.0 121.0 10:15:45 INFO - PROCESS | 1686 | 10:15:45 INFO - PROCESS | 1686 | [#5] imaging-gaussian-blur Cycles:10 Average:103.60 Median:89.00 stddev:20.87 (23.5%) stddev-sans-first:21.55 10:15:45 INFO - PROCESS | 1686 | Values: 90.0 99.0 90.0 87.0 134.0 131.0 95.0 88.0 135.0 87.0 10:15:45 INFO - PROCESS | 1686 | 10:15:45 INFO - PROCESS | 1686 | [#6] imaging-darkroom Cycles:10 Average:108.30 Median:95.50 stddev:22.70 (23.8%) stddev-sans-first:23.56 10:15:45 INFO - PROCESS | 1686 | Values: 95.0 95.0 103.0 97.0 103.0 151.0 151.0 96.0 96.0 96.0 10:15:45 INFO - PROCESS | 1686 | 10:15:45 INFO - PROCESS | 1686 | [#7] imaging-desaturate Cycles:10 Average:111.30 Median:92.00 stddev:21.66 (23.5%) stddev-sans-first:22.95 10:15:45 INFO - PROCESS | 1686 | Values: 114.0 95.0 92.0 92.0 122.0 93.0 150.0 141.0 120.0 94.0 10:15:45 INFO - PROCESS | 1686 | 10:15:45 INFO - PROCESS | 1686 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:60.00 stddev:3.06 (5.1%) stddev-sans-first:3.08 10:15:45 INFO - PROCESS | 1686 | Values: 56.0 60.0 57.0 60.0 60.0 61.0 57.0 65.0 56.0 55.0 10:15:45 INFO - PROCESS | 1686 | 10:15:45 INFO - PROCESS | 1686 | [#9] json-stringify-tinderbox Cycles:10 Average:76.20 Median:69.00 stddev:13.30 (19.3%) stddev-sans-first:13.58 10:15:45 INFO - PROCESS | 1686 | Values: 66.0 95.0 101.0 68.0 78.0 86.0 70.0 65.0 67.0 66.0 10:15:45 INFO - PROCESS | 1686 | 10:15:45 INFO - PROCESS | 1686 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.50 stddev:2.12 (2.5%) stddev-sans-first:2.24 10:15:45 INFO - PROCESS | 1686 | Values: 83.0 84.0 81.0 83.0 83.0 83.0 84.0 84.0 82.0 89.0 10:15:45 INFO - PROCESS | 1686 | 10:15:45 INFO - PROCESS | 1686 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:134.00 stddev:8.54 (6.4%) stddev-sans-first:8.81 10:15:45 INFO - PROCESS | 1686 | Values: 134.0 135.0 113.0 134.0 134.0 131.0 139.0 121.0 119.0 124.0 10:15:45 INFO - PROCESS | 1686 | 10:15:45 INFO - PROCESS | 1686 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.30 Median:156.50 stddev:19.34 (12.4%) stddev-sans-first:19.70 10:15:45 INFO - PROCESS | 1686 | Values: 136.0 150.0 176.0 163.0 136.0 139.0 119.0 148.0 172.0 174.0 10:15:45 INFO - PROCESS | 1686 | 10:15:45 INFO - PROCESS | 1686 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:68.00 stddev:11.29 (16.6%) stddev-sans-first:11.90 10:15:45 INFO - PROCESS | 1686 | Values: 67.0 65.0 68.0 68.0 66.0 66.0 82.0 58.0 68.0 98.0 10:15:45 INFO - PROCESS | 1686 | -------- Summary: end -------- 10:15:45 INFO - PROCESS | 1686 | 10:15:45 INFO - TEST-INFO | 1686: exit 0 10:15:45 INFO - TEST-OK | kraken | took 58003ms 10:15:45 INFO - SUITE-END | took 1167s 10:15:46 INFO - Completed test suite (00:19:27) 10:15:46 INFO - javascript benchmark 10:15:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2798.762105221056, 3222.5649537312465, 3613.9158252524235, 3690.2435000824817, 3699.963000369997, 4566.543345665436, 4875.75621218939, 5935.406459354073, 5971.5521335899875, 6008.549358798085, 5924.940750592493, 5972.0, 5976.133460648203, 6029.7286622102, 6055.969720151393, 4340.43574335336, 4968.801247950078, 5397.487238712316, 5400.78396864125, 5479.232907392969, 5357.49103835137, 5381.7578208980685, 5468.398476167638, 5490.533304669108, 5517.172424136372, 5407.405185429599, 5439.102548079562, 5448.891022179554, 5469.863253418656, 5482.780688772445, 4766.594839438651, 5390.1375779875425, 5450.591205659572, 5504.119340905436, 5511.3937466878615, 5350.91973620396, 5353.197020446925, 5364.0, 5367.892642147174, 5374.0, 4568.017876156642, 5843.9707801461145, 5882.117682347639, 5882.617629854046, 5931.228940237785, 6211.0, 6224.688765561704, 6256.1866957295715, 6271.937280627227, 6309.4636955858805, 6259.561830671855, 6313.715882785285, 6314.242290925073, 6332.905006424908, 6448.613083215022, 6074.149619053292, 6082.482988945945, 6084.4828189603495, 6105.236845394325, 6112.786052488142, 6327.96836015817, 6398.9040164397575, 6472.0, 6516.641584712792, 6551.246606640298, 6270.122182894398, 6295.496360291258, 6310.148130002391, 6319.6208227506495, 6329.873402531924, 6172.290186628506, 6449.967750161313, 6455.322191169954, 6455.838604034937, 6460.935390646127, 6222.3466536013975, 6236.469900058546, 6285.465735412541, 6294.087357333253, 6330.936690633127, 5167.9224811627855, 6251.781187658501, 6263.561550691408, 6271.96864015677, 6311.2426508819235, 4221.6833737469815, 4911.803527858846, 4949.727764972961, 5020.824271150492, 5048.59611231108, 3520.4543295789194, 4419.049904270597, 4503.166914120898, 4569.337446070301, 4597.908041839144, 5878.412158784087, 6051.9697401513595, 6094.39056094387, 6171.043488259327, 6189.535784816157, 6214.937850621526, 6255.218097737783, 6288.937110628926, 6320.083587879732, 6329.873402531924, 6130.356312587203, 6136.754529818757, 6166.907496387557, 6171.352008039181, 6183.288921773964, 5578.079616863172, 5579.0, 5599.524040456607, 5605.271314729141, 5611.158326251095, 5499.890002200013, 6373.298937116913, 6459.160309159874, 6505.414512693786, 6554.377334153343, 6282.8429289266305, 6309.3690630936535, 6315.5894866833505, 6328.430441260124, 6388.977763557994, 6487.3188315226225, 6504.1219435375615, 6505.349465053457, 6510.641914694737, 6511.641859697762, 6200.7519699211525, 6210.689465526615, 6241.344658810759, 6267.091271765659, 6282.623042617458, 5456.48163424474, 6079.6928660338235, 6314.526410519321, 6327.367263273636, 6368.299487056513, 6162.537809664203, 6214.0, 6258.718357673824, 6319.58922670025, 6346.9682651586445, 6158.507319414346, 6213.502919766317, 6266.937330626635, 6301.842453938688, 6324.1146239527425, 6190.81427557174, 6242.781502647567, 6259.655718935503, 6266.216722909637, 6295.5907865988565, 6127.84680382994, 6143.849652621547, 6276.937230627818, 6290.685465726787, 6304.432601065926, 6117.510599152146, 6157.815265542041, 6199.0, 6254.2807577129215, 6286.4342209201395], "unit": "score", "name": "dojo.html", "value": 5810.822559466901}, {"lowerIsBetter": false, "replicates": [469.17893686049416, 590.4715279824558, 621.4934828115086, 622.7508996401436, 688.6419062087715, 39625.0, 39997.20005599886, 40361.79819100904, 40434.59565404345, 40615.39076913845, 41984.95037624061, 41985.7900710496, 42268.78865605676, 42631.78684106583, 42785.0, 9645.807083858335, 9837.360571562862, 9848.16290615295, 9911.752206194831, 9929.354591951536, 9750.317477776558, 9983.650572229973, 10042.046005629454, 10057.798844023115, 10071.194304455663, 9998.25013124015, 10104.69685909424, 10116.089551940324, 10128.696139115802, 10150.390976541394, 9993.950030249838, 10044.698659040241, 10046.146077583415, 10063.496825158712, 10069.546870390814, 9842.409455432697, 9951.651692190739, 9964.451955142464, 9964.90386057533, 10006.399616023062, 34931.0, 40261.19477610431, 40367.596324036975, 40655.59344406577, 41118.177636447406, 3141.6387115481784, 3344.130526063241, 3359.9920023992704, 3404.3191361727504, 3532.6114127445962, 27599.72400276012, 27624.309392265153, 28607.0, 28756.568651470243, 29153.708462915525, 2768.5431903735857, 2769.4461107778525, 2792.8882844686186, 2862.957055644167, 2969.4506516294555, 350300.0, 351236.0, 354405.0, 354679.0, 355649.22175389214, 48113.278300825514, 48702.75648621805, 48818.511814882106, 66930.66534667296, 68425.0, 45703.77148114238, 46243.537564624596, 46410.0, 46443.0, 46503.069938601715, 17386.391476298268, 17550.0, 17564.38524651631, 17569.736453953203, 17616.64766704659, 13638.977076719286, 13831.515896943558, 13948.72102557943, 13993.510227142002, 14082.732554070182, 12592.0, 15067.09597424158, 15213.467528636445, 15316.387344506094, 15535.145566993924, 5200.427952925175, 6125.142480052797, 6407.647579383179, 6498.935010649928, 6524.608523488511, 1002.2633364477103, 1028.3469996552244, 1137.1641843245209, 1146.6674664347413, 1165.3823473558857, 31505.36989260202, 31524.842375787975, 31805.0, 31920.840395797873, 31975.360492790012, 1090.432974853072, 1152.4871432212753, 1166.288563975974, 1219.0, 1307.457405176841, 15268.16025118607, 15567.0, 16045.59886002836, 16108.95291806029, 16306.510804675878, 544400.5559944429, 545120.0, 547942.0, 550012.0, 553722.0, 62796.0, 63178.0, 63325.36674633287, 63582.0, 64131.0, 1538.4538488836527, 1561.156975233384, 1580.6917651058163, 1582.1298285942685, 1587.317453494985, 30064.549031764105, 31096.067117985593, 31149.065528034196, 31172.532412013385, 31310.37379252448, 53898.0, 53938.0, 54400.0, 54499.45500544944, 54617.0, 517011.4149429379, 520550.0, 520960.0, 521556.0, 521792.0, 34026.809061682725, 34617.134571635914, 34735.47896781601, 35134.0, 35429.0, 47992.520074798806, 48106.03787924152, 48200.03599927912, 48245.55263342105, 49038.971335133094, 39433.211335773696, 39880.800595996836, 39937.600623993385, 40437.393439099025, 41515.58484415238, 38562.614373855904, 38848.6115138845, 39150.0, 39400.211995760495, 39934.60065399309, 39001.60998390093, 39390.01524961784, 39756.60243397645, 40221.59778402178, 40377.39433908553, 31167.220819479695, 33572.49641255432, 33734.49398258979, 33906.15234619154, 34025.65974340225, 25349.493010140064, 25652.0, 25705.742942570334, 25759.0, 25995.090171843894], "unit": "score", "name": "ext.html", "value": 19939.30409903121}, {"lowerIsBetter": false, "replicates": [348.51034296812986, 359.96940260077895, 379.07883842263305, 379.2453018493198, 380.2565983502253, 20734.0, 20868.68696969545, 21054.89472552637, 22268.220612278572, 22295.442613934618, 21575.35273941784, 21978.670319945173, 22280.554388912213, 22486.66270005951, 22510.32469025932, 5295.258663787054, 5912.438318359749, 5939.554533410001, 6178.598391104586, 6211.9378806212035, 5064.848054558369, 5379.623426360156, 6122.755089796403, 6168.506519478454, 6174.043023331391, 5791.942080579203, 6102.359252278514, 6120.051392034219, 6147.354527774586, 6154.107654390111, 6051.606645568024, 6065.666388348639, 6085.665288409135, 6087.299960504554, 6103.725332360033, 5282.313299271109, 5311.362636483608, 5322.441143679896, 5329.546988505982, 5348.572114230891, 25555.488890222277, 25758.356041099123, 26039.218823435327, 26100.347491312677, 26561.804718787702, 2107.1360742095667, 2377.690900182965, 2615.5553555895544, 2757.2831063923522, 2762.0608992942293, 8870.334724895658, 10025.949870250675, 10139.847902281472, 10407.959204079607, 13221.405036773369, 1515.780211869284, 1760.4982579964649, 1834.6789311870368, 1850.8519318454491, 2030.187924830065, 112008.0, 116433.25350119756, 118268.0, 118945.40527297395, 120318.39840800827, 11562.132840037031, 11617.941910290394, 11670.416479176178, 11694.064474841993, 11815.0, 12030.759384812254, 14435.639109022359, 14437.85562144365, 14440.422383104768, 14453.566393008226, 8908.777280568038, 8963.731088067369, 9066.682666106786, 9145.954270228607, 9175.495347755937, 9168.587413566405, 9288.024757400512, 9375.34372593912, 9430.292728045286, 9443.150116489549, 4499.52754960731, 4544.318352247124, 4551.817927282872, 4588.426446694163, 4605.240135377625, 1929.070929070929, 1957.6965570336336, 1975.259277770836, 1983.107601579295, 1995.920163193456, 946.6592026870321, 955.5843208204453, 982.1995074014656, 1010.4897027001317, 1023.3961962442195, 21274.93625318728, 21530.354089377342, 21603.919804010053, 21815.563688726135, 21929.890350548463, 1008.7931973945324, 1011.4639241202175, 1062.198040479433, 1070.1278458056659, 1085.337943854264, 11231.10151187903, 11687.941560292315, 11718.824217636742, 11734.823977640342, 11761.294322340687, 560944.1952790292, 666893.0, 671003.0, 676079.0, 702121.0, 83720.325593489, 84968.0, 94951.62620934533, 123681.38159309146, 125396.37301813615, 1005.8742657167854, 1087.635642059903, 1094.43089593411, 1105.3865104866877, 1112.2436743014828, 18533.907330463262, 19107.0, 19179.424617261506, 19288.517787054876, 19338.0, 51663.45009649717, 54209.72895135499, 54627.18059229035, 54934.52092684237, 57717.0, 70364.64817675878, 70789.81024847446, 71508.64245678738, 72040.27959720546, 73107.63446182734, 7083.610401427971, 8196.713115040944, 8271.586420679063, 8309.086000539815, 8372.07907130203, 9054.456732596065, 13571.932140339235, 13671.794923075962, 13723.0, 14118.50585229512, 11653.067754579444, 11756.0, 12008.459619316976, 12025.098117641386, 12102.09234307448, 10147.289689721943, 11300.660980170607, 11422.657320280405, 11926.986206172225, 11986.76026479483, 11916.225445346025, 11922.165448418527, 12087.456064477296, 12102.576409825613, 12242.387880606113, 8202.507849529047, 8264.958675206586, 8301.543415112226, 8303.294219991127, 8423.747287581382, 9022.593983270637, 11948.641540753444, 12045.33750643723, 12089.093318001009, 12103.51585936588], "unit": "score", "name": "jquery.html", "value": 9797.22976631412}, {"lowerIsBetter": false, "replicates": [1645.893016953898, 1653.6692661467705, 1998.5403357227838, 2061.896905154743, 2101.138533201388, 8266.917330826689, 8898.688545900879, 9002.86495702565, 9203.723888283354, 9228.676996305123, 8954.686585969492, 8971.820563588724, 9032.548372581377, 9071.274298056156, 9086.409383390075, 2574.806889483287, 2595.7144714081437, 2601.6877974642975, 2602.128287023849, 2609.425926296212, 2538.708048574419, 2596.0654164500766, 2600.947981040378, 2602.4925139597785, 2607.517609242296, 2566.2044766122563, 2588.637590737298, 2590.3783092057865, 2600.1159605734047, 2609.438970621316, 2326.255598208574, 2466.4820387718423, 2567.717551069381, 2575.5621544337414, 2604.0495219245026, 2291.8166546676225, 2577.768000879911, 2595.1176599956107, 2609.5302845487804, 2616.123598594473, 8832.470051796912, 9171.174594286545, 9199.816003679889, 9202.263818894473, 9206.0, 5605.467480589378, 5687.886242275173, 5715.142728590745, 5747.741351639186, 5772.711364431803, 3723.255348930225, 3734.7572407793405, 3814.0083578269573, 3885.30064588374, 3892.610738926113, 1067.7063807452935, 1076.6716151573767, 1081.8701755789277, 1123.230587047875, 1126.6676330482528, 12263.957563607104, 12348.320842353667, 12420.56528021524, 12483.625491235278, 12564.994800415945, 4322.978385108055, 4993.775280112403, 5028.296038554606, 5075.3402057733, 5164.845054648366, 10552.525136368728, 10609.15126789855, 10624.0, 10647.893521064845, 10687.625933092304, 5777.884442311214, 5788.797392091341, 5835.44563266489, 5843.444872737083, 5880.411958804086, 4677.4387073550715, 5086.18621020635, 5156.793728250828, 5219.973900130551, 5292.603054770908, 4031.0092714193447, 4088.161926805057, 4098.569650186688, 4103.528094269138, 4105.2405305018665, 1365.6449323176046, 1381.6891199480037, 1385.3073463268365, 1385.810419537149, 1386.1336664584635, 1417.893657975656, 1440.3446431873472, 1444.992775036118, 1447.1895738386538, 1460.6713489464785, 8485.0, 8498.617562209716, 8532.146785321542, 8538.70114545988, 8577.0, 532.2456288705931, 539.5548672345252, 544.3386285662939, 545.1903922674825, 546.7047794191171, 6291.653959032297, 6355.142055822497, 6380.106785050097, 6415.775447859302, 6535.967320163369, 10820.78358432827, 11228.943855280835, 11237.887621123848, 11252.030894593414, 11409.771804563863, 10711.25021248505, 10920.2901811382, 11023.283486573508, 11038.11695064393, 11112.333260004425, 8713.259372953244, 8747.08155643661, 8760.605772740242, 8792.78018049541, 8794.0, 8093.716719914774, 8193.057798353266, 8208.097109318089, 8247.752567422987, 8278.875816862632, 9492.460077621945, 9670.468124253233, 9987.550560224952, 10061.144802691853, 10378.169746420117, 7114.466415018997, 9865.408075515492, 10025.248106391904, 10106.545205465625, 10315.020073093045, 8249.216324449168, 8383.077861435358, 8444.240018398374, 8463.111373305714, 8542.0, 7048.929510705032, 8349.290310323691, 8381.078081410918, 8412.242898138951, 8460.323174146177, 7562.584057876869, 7657.310842024244, 7675.53946763196, 7834.843303134019, 7868.803279918048, 7511.248875112664, 7551.73568925085, 7613.08642962848, 7667.808304792425, 7691.384689224737, 8048.718294859652, 8152.347812174893, 8190.180981901762, 8191.0, 8208.794780130305, 7242.96378518104, 7364.521306115085, 7373.8156546086775, 7374.889376659247, 7390.224026477143, 7440.0, 7452.0, 7472.514286571355, 7493.40052795786, 7502.212267711811], "unit": "score", "name": "mootools.html", "value": 5077.825130227935}, {"lowerIsBetter": false, "replicates": [342.7720565823727, 344.6777263258853, 347.7270342780916, 348.8848679935621, 351.64308227149445, 6867.9698045293235, 6886.449084073274, 6905.861882762354, 6908.17101947767, 6912.066870972417, 6786.016027675984, 6787.694553745081, 6796.796096117112, 6844.041834143211, 6913.239543650207, 4892.877678058059, 4978.576820970222, 5093.949060509403, 5099.796008159669, 5150.587952963763, 3883.572806991229, 4121.979390103045, 5116.1302578561545, 5134.974325128369, 5182.238039066717, 5076.974615126919, 5099.821506247282, 5105.0, 5121.487851214886, 5123.769430375642, 5099.235114732783, 5126.692398456067, 5133.460986596409, 5133.537981581639, 5133.82031628893, 3846.826717851054, 4187.602177793105, 4407.779611019436, 4414.984553552701, 4424.181526417623, 6325.272593651743, 6633.071370008202, 6649.767258145942, 6668.799936001879, 6677.399034086907, 5893.882122357529, 5927.407259274038, 5954.136650185742, 5966.582339236255, 5983.910241346383, 6430.6174172552655, 6920.446364290845, 7411.147718012389, 7413.258674132598, 7431.108267007994, 4761.381020467352, 4772.188727916227, 4777.0, 4784.64115191362, 4799.520047995173, 7707.96146019272, 7780.2219778021745, 7796.649150788171, 7798.337141342936, 7817.765467035942, 4619.2609182531305, 4773.236282194832, 4779.713217206979, 4789.185838407479, 4796.25658023007, 4803.759812009385, 4855.975720121377, 4873.31773551703, 4875.902481950341, 4883.951160488421, 5771.567132465082, 5837.211976383134, 5890.911636325459, 5918.970405147947, 5926.170336152942, 7436.739714110088, 7448.292412220831, 7454.329110379983, 7462.738804141829, 7470.775876723707, 1685.3342929543007, 1711.247051297425, 1712.4862541237578, 1713.3831820544594, 1714.2457318779698, 1052.1162223732101, 1084.430673896195, 1103.6688993301977, 1104.0780947908427, 1105.8783533811275, 5450.964316779799, 5840.269966254218, 6201.441870231701, 6879.862402751917, 6938.826529336807, 7371.88942165868, 7577.5453472790705, 7581.12817026038, 7676.270754278335, 7684.884726729104, 6871.4502839772695, 7126.109236345457, 7129.14450265961, 7167.247439018828, 7172.856542869218, 3957.6939609928654, 4090.836366545305, 4097.651699605507, 4099.9180016400105, 4104.0970986382945, 7222.422206223595, 7327.926720732831, 8055.355571554262, 8099.311558517592, 8138.470999385021, 7661.61691915402, 7934.642941067666, 7973.20267973198, 7978.521288722695, 7990.200979901963, 7209.954556589265, 8040.15578364275, 8065.879011814827, 8076.111627720946, 8086.797830054295, 7066.611336376549, 7701.1913749057785, 7705.190954949874, 7708.190639982721, 7746.535207887319, 7565.697372105275, 7566.24337566239, 7577.0, 7577.355924746458, 7605.163432022362, 5698.888716700204, 7453.962730186315, 7731.33776238089, 7946.64240109208, 8077.636506357346, 4823.27650852375, 4840.709557426566, 4874.317595536699, 4882.998985208095, 4894.314795928644, 6229.781957631461, 7700.537967721954, 7715.112762032214, 7723.575203363869, 7760.262775036363, 7313.853722925618, 7380.483366164317, 7407.222241664547, 7455.92544074574, 7458.105027396748, 6091.390860914051, 7197.604131772593, 7405.111386633638, 7437.702491900263, 7444.0, 7250.057492525938, 7286.781396558112, 7287.599182045038, 7300.379467745089, 7316.561006339637, 7408.222136675787, 7417.406607471282, 7441.144268409203, 7446.962765186139, 7451.701931922879, 7039.084918960502, 7262.782116536512, 7279.344858962719, 7301.963490182515, 7323.63381830917], "unit": "score", "name": "prototype.html", "value": 5359.411613148821}, {"lowerIsBetter": false, "replicates": [749.142232144195, 752.6688257166846, 764.0334976255036, 768.7693691892431, 794.4994653368377, 15382.153981531012, 15653.686926261482, 15667.29497172627, 15689.92155039226, 15776.921115394407, 14527.273636318168, 14590.41638334468, 14594.489192878225, 14602.561923142297, 14604.415823367053, 796.7330944133722, 963.0, 990.173205373514, 1015.6343716262139, 1020.7754294055296, 967.1440774914181, 977.3402953006728, 977.5405559387077, 991.2466525440645, 993.7813680990207, 1054.051353781595, 1063.9148868090572, 1068.1294744783015, 1068.593934304963, 1069.3530414099475, 1049.8687664041995, 1053.515382923856, 1057.1225882517492, 1058.8729352477712, 1059.6450189186633, 778.1557010643459, 784.3646646216525, 787.263908245792, 790.3400660448532, 795.9930687680089, 12630.873691263061, 15365.078095314317, 15509.767353489706, 15574.14342211178, 15607.063576185465, 11609.955104040677, 12937.676558086028, 12986.545470908568, 13169.144005639699, 13317.334133293296, 9605.135537801561, 9755.951220243924, 9791.216702663769, 9933.25500587459, 10143.543540540619, 3576.7138628909624, 3580.8030558319283, 3618.2582570572968, 3709.350863598859, 3886.7862267575274, 77793.0, 79947.60026199832, 81972.59013704893, 82032.0, 82359.0, 9861.0, 9885.75285617851, 10001.949990250148, 10059.446730429896, 10105.040021197974, 22099.33701988943, 22471.213507527485, 22510.32469025932, 22674.546509069725, 22698.205562805222, 7648.464607477423, 7819.765407037798, 7920.643571039317, 7939.28546430824, 8138.470999385021, 4208.558101399371, 4275.935860962088, 4291.871243862689, 4297.871063868089, 4414.977925110354, 3679.2641471705765, 3691.298653255873, 3719.8326075326677, 3725.925481490355, 3751.8311675974646, 664.9858965078295, 689.0628744906923, 689.162667359151, 689.1798759476208, 691.1740470138137, 605.3190161068798, 609.7957184343295, 613.9324674285825, 619.485826763785, 621.4841681404423, 7900.814877768265, 8544.700935467228, 8568.314534837198, 8719.60761765722, 8730.69442569507, 588.5997521685209, 601.9646208521336, 603.7072020070262, 607.1753490763783, 611.403881215811, 3923.1761330120426, 4002.399640053957, 4024.1549274652652, 4035.435039094529, 4216.262154123016, 71242.28757712357, 93940.06059939312, 93950.53024734833, 94046.0, 94369.0, 62268.68865655643, 75166.36917707854, 82514.0, 82673.0, 83183.58408207921, 55898.0, 70116.0, 73044.63477682577, 73528.89706654404, 74584.0, 8566.700165494178, 8576.957115214384, 8639.265662418766, 8722.0, 8745.737627871174, 37130.6286937138, 47883.0, 47923.04153916833, 52109.7394513025, 53105.20342194793, 73365.0, 73392.63303683448, 73503.26496734965, 73565.26434735584, 73903.63048184724, 9863.556139973862, 10778.0, 11338.376389298668, 11605.284904965356, 11698.649040528799, 12294.692632684255, 12329.753404932031, 12446.751064978831, 12773.169743966613, 12935.935320323339, 11957.581484648343, 11995.880041199476, 12037.638870833889, 12131.636050918487, 12161.69595760113, 11799.17405781587, 11856.70358241051, 12056.156069075432, 12140.271583705005, 12266.141370104364, 11644.708882278012, 11731.634743342482, 11761.235519691192, 11767.941160294144, 11893.167478276784, 9932.0, 9950.55222514974, 10170.186385089028, 10171.186305095722, 10211.948940255252, 8267.958660206661, 10046.799064018825, 10142.442165680959, 10233.437160956219, 10242.0], "unit": "score", "name": "yui.html", "value": 7186.629655923386}], "name": "dromaeo_css", "value": 7781.571852968901}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 114.0, 116.0, 116.0, 117.0, 128.0, 115.0, 114.0, 115.0, 117.0], "unit": "score", "name": "ai-astar", "value": 116.9}, {"lowerIsBetter": true, "replicates": [167.0, 146.0, 131.0, 147.0, 135.0, 173.0, 171.0, 153.0, 187.0, 155.0], "unit": "score", "name": "audio-beat-detection", "value": 156.5}, {"lowerIsBetter": true, "replicates": [196.0, 195.0, 201.0, 248.0, 202.0, 245.0, 246.0, 218.0, 221.0, 184.0], "unit": "score", "name": "audio-dft", "value": 215.6}, {"lowerIsBetter": true, "replicates": [85.0, 79.0, 67.0, 108.0, 54.0, 57.0, 67.0, 88.0, 170.0, 59.0], "unit": "score", "name": "audio-fft", "value": 83.4}, {"lowerIsBetter": true, "replicates": [82.0, 90.0, 119.0, 77.0, 80.0, 81.0, 120.0, 79.0, 80.0, 121.0], "unit": "score", "name": "audio-oscillator", "value": 92.9}, {"lowerIsBetter": true, "replicates": [90.0, 99.0, 90.0, 87.0, 134.0, 131.0, 95.0, 88.0, 135.0, 87.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 103.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 103.0, 97.0, 103.0, 151.0, 151.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 108.3}, {"lowerIsBetter": true, "replicates": [114.0, 95.0, 92.0, 92.0, 122.0, 93.0, 150.0, 141.0, 120.0, 94.0], "unit": "score", "name": "imaging-desaturate", "value": 111.3}, {"lowerIsBetter": true, "replicates": [56.0, 60.0, 57.0, 60.0, 60.0, 61.0, 57.0, 65.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.7}, {"lowerIsBetter": true, "replicates": [66.0, 95.0, 101.0, 68.0, 78.0, 86.0, 70.0, 65.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 76.2}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 81.0, 83.0, 83.0, 83.0, 84.0, 84.0, 82.0, 89.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.6}, {"lowerIsBetter": true, "replicates": [134.0, 135.0, 113.0, 134.0, 134.0, 131.0, 139.0, 121.0, 119.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.4}, {"lowerIsBetter": true, "replicates": [136.0, 150.0, 176.0, 163.0, 136.0, 139.0, 119.0, 148.0, 172.0, 174.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.3}, {"lowerIsBetter": true, "replicates": [67.0, 65.0, 68.0, 68.0, 66.0, 66.0, 82.0, 58.0, 68.0, 98.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.6}], "name": "kraken", "value": 1557.2999999999997}]} 10:15:46 INFO - Return code: 0 10:15:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:15:46 ERROR - # TBPL SUCCESS # 10:15:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:15:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:15:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:15:46 INFO - 2016-04-27 10:15:46.393 screenresolution[1691:10905] starting screenresolution argv=screenresolution get 10:15:46 INFO - 2016-04-27 10:15:46.396 screenresolution[1691:10905] Display 0: 1600x1200x32@60 10:15:46 INFO - 2016-04-27 10:15:46.402 screenresolution[1692:10908] starting screenresolution argv=screenresolution list 10:15:46 INFO - Available Modes on Display 0 10:15:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:15:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:15:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:15:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:15:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:15:46 INFO - Intel Iris: 10:15:46 INFO - Chipset Model: Intel Iris 10:15:46 INFO - Type: GPU 10:15:46 INFO - Bus: Built-In 10:15:46 INFO - VRAM (Dynamic, Max): 1536 MB 10:15:46 INFO - Vendor: Intel (0x8086) 10:15:46 INFO - Device ID: 0x0a2e 10:15:46 INFO - Revision ID: 0x0009 10:15:46 INFO - Displays: 10:15:46 INFO - Display: 10:15:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:15:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:15:46 INFO - Display Serial Number: 1600x1200 60 10:15:46 INFO - Main Display: Yes 10:15:46 INFO - Mirror: Off 10:15:46 INFO - Online: Yes 10:15:46 INFO - Rotation: Supported 10:15:46 INFO - Return code: 0 10:15:46 INFO - Running post-action listener: _resource_record_post_action 10:15:46 INFO - Running post-run listener: _resource_record_post_run 10:15:47 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 37754368; Write bytes: 511013888; Read time: 396; Write time: 2310 10:15:47 INFO - install - Wall time: 23s; CPU: 55.0%; Read bytes: 201443840; Write bytes: 195203072; Read time: 18069; Write time: 370 10:15:47 INFO - run-tests - Wall time: 1170s; CPU: 53.0%; Read bytes: 31415808; Write bytes: 303750656; Read time: 311; Write time: 1873 10:15:47 INFO - Running post-run listener: _upload_blobber_files 10:15:47 INFO - Blob upload gear active. 10:15:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:15:47 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 10:15:47 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'] 10:15:47 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 10:15:48 INFO - (blobuploader) - INFO - Open directory for files ... 10:15:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:15:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:15:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:15:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:15:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:15:48 INFO - (blobuploader) - INFO - Done attempting. 10:15:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:15:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:15:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:15:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:15:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:15:49 INFO - (blobuploader) - INFO - Done attempting. 10:15:49 INFO - (blobuploader) - INFO - Iteration through files over. 10:15:49 INFO - Return code: 0 10:15:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:15:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:15:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/43f402ad656273d6cbea11fa5a1971fcc38f6fedb1ab2b3570c42ddb9695468049f9751e807b5a8d20dc920d2b8fd7333752a4e0848b468fd86f4f84d4a4ccaa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/234ed897e6d4fefa109b0afd91391447a2b55e51d26299d6da126a46684b8010efd7154924c53666225914a5869d705984df32c0d80acdd066c82c659ce4d319"} 10:15:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:15:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:15:49 INFO - Contents: 10:15:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/43f402ad656273d6cbea11fa5a1971fcc38f6fedb1ab2b3570c42ddb9695468049f9751e807b5a8d20dc920d2b8fd7333752a4e0848b468fd86f4f84d4a4ccaa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/234ed897e6d4fefa109b0afd91391447a2b55e51d26299d6da126a46684b8010efd7154924c53666225914a5869d705984df32c0d80acdd066c82c659ce4d319"} 10:15:49 INFO - Running post-run listener: copy_logs_to_upload_dir 10:15:49 INFO - Copying logs to upload dir... 10:15:49 INFO - mkdir: /builds/slave/test/build/upload/logs 10:15:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.093686 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-04-27 10:15:50.028542) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 10:15:50.035482) ========= 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.n8QndI80IQ/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.915j0FKsJ8/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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/43f402ad656273d6cbea11fa5a1971fcc38f6fedb1ab2b3570c42ddb9695468049f9751e807b5a8d20dc920d2b8fd7333752a4e0848b468fd86f4f84d4a4ccaa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/234ed897e6d4fefa109b0afd91391447a2b55e51d26299d6da126a46684b8010efd7154924c53666225914a5869d705984df32c0d80acdd066c82c659ce4d319"} build_url:https://queue.taskcluster.net/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010946 build_url: 'https://queue.taskcluster.net/v1/task/O7uQABnTS4iiwv0pt2Yosw/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/43f402ad656273d6cbea11fa5a1971fcc38f6fedb1ab2b3570c42ddb9695468049f9751e807b5a8d20dc920d2b8fd7333752a4e0848b468fd86f4f84d4a4ccaa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/234ed897e6d4fefa109b0afd91391447a2b55e51d26299d6da126a46684b8010efd7154924c53666225914a5869d705984df32c0d80acdd066c82c659ce4d319"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 10:15:50.099946) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 10:15:50.104288) ========= 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.n8QndI80IQ/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.915j0FKsJ8/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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.005262 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 10:15:50.158730) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 10:15:50.159035) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 10:15:50.172462) ========= ========= Total master_lag: 12.50 =========