builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0111 starttime: 1462964860.98 results: success (0) buildid: 20160511020936 builduid: f848e7aa39974b6aa452e72df7065c49 revision: a4a650440913082f894933d142b68d3d16ec1abb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 04:07:40.984507) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 04:07:40.988151) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 04:07:40.988444) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 04:07:41.006247) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:07:41.006648) ========= 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.Dg5QJn5r7a/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.Y2E1dIrdav/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-11 04:07:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 72.4M=0s 2016-05-11 04:07:41 (72.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.318948 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:07:41.342502) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:07:41.342803) ========= 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.Dg5QJn5r7a/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.Y2E1dIrdav/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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.020021 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:07:41.390946) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:07:41.391302) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a4a650440913082f894933d142b68d3d16ec1abb --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 a4a650440913082f894933d142b68d3d16ec1abb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Dg5QJn5r7a/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.Y2E1dIrdav/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-11 04:07:41,463 truncating revision to first 12 chars 2016-05-11 04:07:41,463 Setting DEBUG logging. 2016-05-11 04:07:41,463 attempt 1/10 2016-05-11 04:07:41,463 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a4a650440913?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 04:07:42,056 unpacking tar archive at: mozilla-beta-a4a650440913/testing/mozharness/ program finished with exit code 0 elapsedTime=0.841946 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:07:42.249305) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 04:07:42.249571) ========= script_repo_revision: a4a650440913082f894933d142b68d3d16ec1abb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 04:07:42.249911) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 04:07:42.250180) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 04:07:42.263475) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-05-11 04:07:42.263974) ========= /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.Dg5QJn5r7a/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.Y2E1dIrdav/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 04:07:42 INFO - MultiFileLogger online at 20160511 04:07:42 in /builds/slave/test 04:07:42 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 04:07:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:07:42 INFO - {'append_to_log': False, 04:07:42 INFO - 'base_work_dir': '/builds/slave/test', 04:07:42 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:07:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:07:42 INFO - 'branch': 'Mozilla-Beta', 04:07:42 INFO - 'buildbot_json_path': 'buildprops.json', 04:07:42 INFO - 'config_files': ('talos/mac_config.py',), 04:07:42 INFO - 'default_actions': ('clobber', 04:07:42 INFO - 'read-buildbot-config', 04:07:42 INFO - 'download-and-extract', 04:07:42 INFO - 'populate-webroot', 04:07:42 INFO - 'create-virtualenv', 04:07:42 INFO - 'install', 04:07:42 INFO - 'run-tests'), 04:07:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:07:42 INFO - 'download_minidump_stackwalk': True, 04:07:42 INFO - 'download_symbols': 'ondemand', 04:07:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:07:42 INFO - 'tooltool.py': '/tools/tooltool.py', 04:07:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:07:42 INFO - '/tools/misc-python/virtualenv.py')}, 04:07:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:07:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:07:42 INFO - 'installer_path': 'installer.exe', 04:07:42 INFO - 'log_level': 'info', 04:07:42 INFO - 'log_name': 'talos', 04:07:42 INFO - 'log_to_console': True, 04:07:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:07:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:07:42 INFO - 'opt_config_files': (), 04:07:42 INFO - 'pip_index': False, 04:07:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:07:42 INFO - 'cmd': ('bash', 04:07:42 INFO - '-c', 04:07:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:07:42 INFO - 'enabled': True, 04:07:42 INFO - 'halt_on_failure': False, 04:07:42 INFO - 'name': 'check_screen_resolution'},), 04:07:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:07:42 INFO - 'cmd': ('bash', 04:07:42 INFO - '-c', 04:07:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:07:42 INFO - 'enabled': True, 04:07:42 INFO - 'halt_on_failure': False, 04:07:42 INFO - 'name': 'check_screen_resolution'},), 04:07:42 INFO - 'run_cmd_checks_enabled': True, 04:07:42 INFO - 'sps_profile': False, 04:07:42 INFO - 'sps_profile_interval': 0, 04:07:42 INFO - 'suite': 'dromaeojs-e10s', 04:07:42 INFO - 'system_bits': '32', 04:07:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:07:42 INFO - 'title': 't-yosemite-r7-0111', 04:07:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:07:42 INFO - 'use_talos_json': True, 04:07:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:07:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:07:42 INFO - 'work_dir': 'build'} 04:07:42 INFO - ##### 04:07:42 INFO - ##### Running clobber step. 04:07:42 INFO - ##### 04:07:42 INFO - Running pre-action listener: _resource_record_pre_action 04:07:42 INFO - Running main action method: clobber 04:07:42 INFO - rmtree: /builds/slave/test/build 04:07:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:07:43 INFO - Running post-action listener: _resource_record_post_action 04:07:43 INFO - ##### 04:07:43 INFO - ##### Running read-buildbot-config step. 04:07:43 INFO - ##### 04:07:43 INFO - Running pre-action listener: _resource_record_pre_action 04:07:43 INFO - Running main action method: read_buildbot_config 04:07:43 INFO - Using buildbot properties: 04:07:43 INFO - { 04:07:43 INFO - "project": "", 04:07:43 INFO - "product": "firefox", 04:07:43 INFO - "script_repo_revision": "production", 04:07:43 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 04:07:43 INFO - "repository": "", 04:07:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 04:07:43 INFO - "buildid": "20160511020936", 04:07:43 INFO - "pgo_build": "False", 04:07:43 INFO - "basedir": "/builds/slave/test", 04:07:43 INFO - "buildnumber": 5, 04:07:43 INFO - "slavename": "t-yosemite-r7-0111", 04:07:43 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 04:07:43 INFO - "platform": "yosemite_r7", 04:07:43 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 04:07:43 INFO - "branch": "mozilla-beta", 04:07:43 INFO - "repo_path": "releases/mozilla-beta", 04:07:43 INFO - "revision": "a4a650440913082f894933d142b68d3d16ec1abb", 04:07:43 INFO - "stage_platform": "macosx64", 04:07:43 INFO - "builduid": "f848e7aa39974b6aa452e72df7065c49", 04:07:43 INFO - "slavebuilddir": "test" 04:07:43 INFO - } 04:07:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/EZxbnFY2RleldqUphQOzRQ/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 04:07:43 INFO - Running post-action listener: _resource_record_post_action 04:07:43 INFO - ##### 04:07:43 INFO - ##### Running download-and-extract step. 04:07:43 INFO - ##### 04:07:43 INFO - Running pre-action listener: _resource_record_pre_action 04:07:43 INFO - Running main action method: download_and_extract 04:07:43 INFO - mkdir: /builds/slave/test/build/tests 04:07:43 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')]} 04:07:43 INFO - https://queue.taskcluster.net/v1/task/EZxbnFY2RleldqUphQOzRQ/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:07:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZxbnFY2RleldqUphQOzRQ/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 04:07:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZxbnFY2RleldqUphQOzRQ/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 04:07:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZxbnFY2RleldqUphQOzRQ/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 04:07:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZxbnFY2RleldqUphQOzRQ/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 04:07:47 INFO - Downloaded 1241 bytes. 04:07:47 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 04:07:47 INFO - Using the following test package requirements: 04:07:47 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 04:07:47 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 04:07:47 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 04:07:47 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 04:07:47 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 04:07:47 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 04:07:47 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 04:07:47 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 04:07:47 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 04:07:47 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 04:07:47 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 04:07:47 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 04:07:47 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 04:07:47 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 04:07:47 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 04:07:47 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 04:07:47 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 04:07:47 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 04:07:47 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 04:07:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:47 INFO - https://queue.taskcluster.net/v1/task/EZxbnFY2RleldqUphQOzRQ/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:07:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZxbnFY2RleldqUphQOzRQ/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 04:07:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZxbnFY2RleldqUphQOzRQ/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 04:07:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZxbnFY2RleldqUphQOzRQ/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 04:07:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZxbnFY2RleldqUphQOzRQ/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 04:08:02 INFO - Downloaded 17747473 bytes. 04:08:02 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'] 04:08:02 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 04:08:05 INFO - Return code: 0 04:08:05 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 04:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:05 INFO - https://queue.taskcluster.net/v1/task/EZxbnFY2RleldqUphQOzRQ/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:08:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZxbnFY2RleldqUphQOzRQ/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 04:08:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZxbnFY2RleldqUphQOzRQ/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 04:08:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZxbnFY2RleldqUphQOzRQ/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 04:08:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZxbnFY2RleldqUphQOzRQ/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 04:08:12 INFO - Downloaded 17747473 bytes. 04:08:12 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'] 04:08:12 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 04:08:16 INFO - Return code: 0 04:08: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')]} 04:08:16 INFO - https://queue.taskcluster.net/v1/task/EZxbnFY2RleldqUphQOzRQ/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:08:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZxbnFY2RleldqUphQOzRQ/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 04:08:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZxbnFY2RleldqUphQOzRQ/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 04:08:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZxbnFY2RleldqUphQOzRQ/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 04:08:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZxbnFY2RleldqUphQOzRQ/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 04:08:17 INFO - Downloaded 10845194 bytes. 04:08:17 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'] 04:08:17 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 04:08:17 INFO - Return code: 0 04:08:17 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')]} 04:08:17 INFO - https://queue.taskcluster.net/v1/task/EZxbnFY2RleldqUphQOzRQ/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 04:08:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZxbnFY2RleldqUphQOzRQ/artifacts/public/build/firefox-47.0.en-US.mac.dmg 04:08:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZxbnFY2RleldqUphQOzRQ/artifacts/public/build/firefox-47.0.en-US.mac.dmg 04:08:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZxbnFY2RleldqUphQOzRQ/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 04:08:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZxbnFY2RleldqUphQOzRQ/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 04:08:20 INFO - Downloaded 88379196 bytes. 04:08:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EZxbnFY2RleldqUphQOzRQ/artifacts/public/build/firefox-47.0.en-US.mac.dmg 04:08:20 INFO - mkdir: /builds/slave/test/properties 04:08:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:08:20 INFO - Writing to file /builds/slave/test/properties/build_url 04:08:20 INFO - Contents: 04:08:20 INFO - build_url:https://queue.taskcluster.net/v1/task/EZxbnFY2RleldqUphQOzRQ/artifacts/public/build/firefox-47.0.en-US.mac.dmg 04:08:21 INFO - Running post-action listener: _resource_record_post_action 04:08:21 INFO - Running post-action listener: set_extra_try_arguments 04:08:21 INFO - ##### 04:08:21 INFO - ##### Running populate-webroot step. 04:08:21 INFO - ##### 04:08:21 INFO - Running pre-action listener: _resource_record_pre_action 04:08:21 INFO - Running main action method: populate_webroot 04:08:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:08:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:08:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:08:21 INFO - '--tppagecycles', 04:08:21 INFO - '7'], 04:08:21 INFO - 'tests': ['tsvgm']}}, 04:08:21 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:08:21 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:08:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:08:21 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:08:21 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:08:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:08:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:21 INFO - 'talos_options': ['--e10s'], 04:08:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:21 INFO - 'tests': ['damp', 'tps']}, 04:08:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:21 INFO - 'talos_options': ['--e10s'], 04:08:21 INFO - 'tests': ['damp', 'tps']}, 04:08:21 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:08:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:08:21 INFO - 'other': {'tests': ['a11yr', 04:08:21 INFO - 'ts_paint', 04:08:21 INFO - 'tpaint', 04:08:21 INFO - 'sessionrestore', 04:08:21 INFO - 'sessionrestore_no_auto_restore', 04:08:21 INFO - 'tabpaint']}, 04:08:21 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:08:21 INFO - 'tests': ['a11yr', 04:08:21 INFO - 'ts_paint', 04:08:21 INFO - 'tpaint', 04:08:21 INFO - 'sessionrestore', 04:08:21 INFO - 'sessionrestore_no_auto_restore', 04:08:21 INFO - 'tabpaint']}, 04:08:21 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:08:21 INFO - 'tests': ['a11yr', 04:08:21 INFO - 'ts_paint', 04:08:21 INFO - 'tpaint', 04:08:21 INFO - 'sessionrestore', 04:08:21 INFO - 'sessionrestore_no_auto_restore', 04:08:21 INFO - 'tabpaint']}, 04:08:21 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:08:21 INFO - 'tests': ['a11yr', 04:08:21 INFO - 'ts_paint', 04:08:21 INFO - 'tpaint', 04:08:21 INFO - 'sessionrestore', 04:08:21 INFO - 'sessionrestore_no_auto_restore', 04:08:21 INFO - 'tabpaint']}, 04:08:21 INFO - 'other_l64': {'tests': ['a11yr', 04:08:21 INFO - 'ts_paint', 04:08:21 INFO - 'tpaint', 04:08:21 INFO - 'sessionrestore', 04:08:21 INFO - 'sessionrestore_no_auto_restore', 04:08:21 INFO - 'tabpaint']}, 04:08:21 INFO - 'other_nol64': {'tests': ['a11yr', 04:08:21 INFO - 'ts_paint', 04:08:21 INFO - 'tpaint', 04:08:21 INFO - 'sessionrestore', 04:08:21 INFO - 'sessionrestore_no_auto_restore', 04:08:21 INFO - 'tabpaint']}, 04:08:21 INFO - 'svgr': {'tests': ['tsvgx', 04:08:21 INFO - 'tsvgr_opacity', 04:08:21 INFO - 'tart', 04:08:21 INFO - 'tscrollx', 04:08:21 INFO - 'cart']}, 04:08:21 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:08:21 INFO - 'tests': ['tsvgx', 04:08:21 INFO - 'tsvgr_opacity', 04:08:21 INFO - 'tart', 04:08:21 INFO - 'tscrollx', 04:08:21 INFO - 'cart']}, 04:08:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:21 INFO - 'tests': ['tp5o']}, 04:08:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:21 INFO - 'talos_options': ['--e10s'], 04:08:21 INFO - 'tests': ['tp5o']}, 04:08:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:21 INFO - 'talos_options': ['--xperf_path', 04:08:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:21 INFO - 'tests': ['tp5n']}, 04:08:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:21 INFO - 'talos_options': ['--e10s', 04:08:21 INFO - '--xperf_path', 04:08:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:21 INFO - 'tests': ['tp5n']}}, 04:08:21 INFO - 'talos.zip': {'path': '', 04:08:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:08:21 INFO - Running post-action listener: _resource_record_post_action 04:08:21 INFO - ##### 04:08:21 INFO - ##### Running create-virtualenv step. 04:08:21 INFO - ##### 04:08:21 INFO - Running pre-action listener: _resource_record_pre_action 04:08:21 INFO - Running main action method: create_virtualenv 04:08:21 INFO - Creating virtualenv /builds/slave/test/build/venv 04:08:21 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 04:08:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:08:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:08:21 INFO - Using real prefix '/tools/python27' 04:08:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:08:22 INFO - Installing distribute.............................................................................................................................................................................................done. 04:08:25 INFO - Installing pip.................done. 04:08:25 INFO - Return code: 0 04:08:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:25 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 0x108762a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087694c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff44344da30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108606d30>, '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 0x10846adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085fdb20>, '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.Dg5QJn5r7a/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.Y2E1dIrdav/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 04:08:25 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 04:08:25 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 04:08:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dg5QJn5r7a/Render', 04:08:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:25 INFO - 'HOME': '/Users/cltbld', 04:08:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:25 INFO - 'LOGNAME': 'cltbld', 04:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:25 INFO - 'MOZ_NO_REMOTE': '1', 04:08:25 INFO - 'NO_EM_RESTART': '1', 04:08:25 INFO - 'PAGER': '/bin/cat', 04:08:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:25 INFO - 'PWD': '/builds/slave/test', 04:08:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:25 INFO - 'SHELL': '/bin/bash', 04:08:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y2E1dIrdav/Listeners', 04:08:25 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 04:08:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:25 INFO - 'USER': 'cltbld', 04:08:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:25 INFO - 'XPC_FLAGS': '0x0', 04:08:25 INFO - 'XPC_SERVICE_NAME': '0', 04:08:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:08:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:25 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 04:08:25 INFO - Cleaning up... 04:08:25 INFO - Return code: 0 04:08:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:25 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 0x108762a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087694c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff44344da30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108606d30>, '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 0x10846adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085fdb20>, '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.Dg5QJn5r7a/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.Y2E1dIrdav/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 04:08:25 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 04:08:25 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 04:08:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dg5QJn5r7a/Render', 04:08:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:25 INFO - 'HOME': '/Users/cltbld', 04:08:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:25 INFO - 'LOGNAME': 'cltbld', 04:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:25 INFO - 'MOZ_NO_REMOTE': '1', 04:08:25 INFO - 'NO_EM_RESTART': '1', 04:08:25 INFO - 'PAGER': '/bin/cat', 04:08:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:25 INFO - 'PWD': '/builds/slave/test', 04:08:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:25 INFO - 'SHELL': '/bin/bash', 04:08:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y2E1dIrdav/Listeners', 04:08:25 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 04:08:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:25 INFO - 'USER': 'cltbld', 04:08:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:25 INFO - 'XPC_FLAGS': '0x0', 04:08:25 INFO - 'XPC_SERVICE_NAME': '0', 04:08:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:08:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:25 INFO - Downloading/unpacking psutil>=0.7.1 04:08:25 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 04:08:25 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 04:08:25 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 04:08:25 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 04:08:25 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 04:08:25 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 04:08:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:08:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:28 INFO - Installing collected packages: psutil 04:08:28 INFO - Running setup.py install for psutil 04:08:28 INFO - building 'psutil._psutil_osx' extension 04:08:28 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 04:08:29 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 04:08:29 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 04:08:29 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 04:08:29 INFO - building 'psutil._psutil_posix' extension 04:08:29 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 04:08:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:08:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:08:29 INFO - ^ 04:08:29 INFO - 1 warning generated. 04:08:29 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 04:08:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:29 INFO - Successfully installed psutil 04:08:29 INFO - Cleaning up... 04:08:29 INFO - Return code: 0 04:08:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:29 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 0x108762a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087694c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff44344da30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108606d30>, '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 0x10846adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085fdb20>, '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.Dg5QJn5r7a/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.Y2E1dIrdav/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 04:08:29 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 04:08:29 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 04:08:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dg5QJn5r7a/Render', 04:08:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:29 INFO - 'HOME': '/Users/cltbld', 04:08:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:29 INFO - 'LOGNAME': 'cltbld', 04:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:29 INFO - 'MOZ_NO_REMOTE': '1', 04:08:29 INFO - 'NO_EM_RESTART': '1', 04:08:29 INFO - 'PAGER': '/bin/cat', 04:08:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:29 INFO - 'PWD': '/builds/slave/test', 04:08:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:29 INFO - 'SHELL': '/bin/bash', 04:08:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y2E1dIrdav/Listeners', 04:08:29 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 04:08:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:29 INFO - 'USER': 'cltbld', 04:08:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:29 INFO - 'XPC_FLAGS': '0x0', 04:08:29 INFO - 'XPC_SERVICE_NAME': '0', 04:08:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:08:29 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 04:08:29 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 04:08:29 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 04:08:29 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 04:08:29 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 04:08:29 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 04:08:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:08:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:08:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:08:32 INFO - Installing collected packages: mozsystemmonitor 04:08:32 INFO - Running setup.py install for mozsystemmonitor 04:08:32 INFO - Successfully installed mozsystemmonitor 04:08:32 INFO - Cleaning up... 04:08:32 INFO - Return code: 0 04:08:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:32 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 0x108762a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087694c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff44344da30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108606d30>, '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 0x10846adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085fdb20>, '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.Dg5QJn5r7a/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.Y2E1dIrdav/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 04:08:32 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 04:08:32 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 04:08:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dg5QJn5r7a/Render', 04:08:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:32 INFO - 'HOME': '/Users/cltbld', 04:08:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:32 INFO - 'LOGNAME': 'cltbld', 04:08:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:32 INFO - 'MOZ_NO_REMOTE': '1', 04:08:32 INFO - 'NO_EM_RESTART': '1', 04:08:32 INFO - 'PAGER': '/bin/cat', 04:08:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:32 INFO - 'PWD': '/builds/slave/test', 04:08:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:32 INFO - 'SHELL': '/bin/bash', 04:08:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y2E1dIrdav/Listeners', 04:08:32 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 04:08:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:32 INFO - 'USER': 'cltbld', 04:08:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:32 INFO - 'XPC_FLAGS': '0x0', 04:08:32 INFO - 'XPC_SERVICE_NAME': '0', 04:08:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:08:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:32 INFO - Downloading/unpacking blobuploader==1.2.4 04:08:32 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 04:08:32 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 04:08:32 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 04:08:32 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 04:08:32 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 04:08:32 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 04:08:35 INFO - Downloading blobuploader-1.2.4.tar.gz 04:08:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:08:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:08:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:36 INFO - Downloading docopt-0.6.1.tar.gz 04:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:08:36 INFO - Installing collected packages: blobuploader, requests, docopt 04:08:36 INFO - Running setup.py install for blobuploader 04:08:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:08:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:08:36 INFO - Running setup.py install for requests 04:08:37 INFO - Running setup.py install for docopt 04:08:37 INFO - Successfully installed blobuploader requests docopt 04:08:37 INFO - Cleaning up... 04:08:37 INFO - Return code: 0 04:08:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:38 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 0x108762a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087694c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff44344da30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108606d30>, '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 0x10846adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085fdb20>, '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.Dg5QJn5r7a/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.Y2E1dIrdav/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 04:08:38 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 04:08:38 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 04:08:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dg5QJn5r7a/Render', 04:08:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:38 INFO - 'HOME': '/Users/cltbld', 04:08:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:38 INFO - 'LOGNAME': 'cltbld', 04:08:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:38 INFO - 'MOZ_NO_REMOTE': '1', 04:08:38 INFO - 'NO_EM_RESTART': '1', 04:08:38 INFO - 'PAGER': '/bin/cat', 04:08:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:38 INFO - 'PWD': '/builds/slave/test', 04:08:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:38 INFO - 'SHELL': '/bin/bash', 04:08:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y2E1dIrdav/Listeners', 04:08:38 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 04:08:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:38 INFO - 'USER': 'cltbld', 04:08:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:38 INFO - 'XPC_FLAGS': '0x0', 04:08:38 INFO - 'XPC_SERVICE_NAME': '0', 04:08:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:08:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:08:38 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-ZOXo3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:08:38 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-rbJj6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:08:38 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-PG9FIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:08:38 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-6zTYy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:08:38 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-yeWCJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:08:38 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-1lSvF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:08:39 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-6ZfgwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:08:39 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-TNLt5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:08:39 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-nRGJUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:08:39 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-IsYX56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:08:39 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-LcERc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:08:39 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-43oney-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:08:39 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-MVnPVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:08:39 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-RdUlq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:39 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-Mv9jeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:08:39 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-H5B7DH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:08:40 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-aAea4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:08:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:08:40 INFO - Running setup.py install for manifestparser 04:08:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:08:40 INFO - Running setup.py install for mozcrash 04:08:40 INFO - Running setup.py install for mozdebug 04:08:40 INFO - Running setup.py install for mozdevice 04:08:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:08:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:08:40 INFO - Running setup.py install for mozfile 04:08:40 INFO - Running setup.py install for mozhttpd 04:08:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:08:41 INFO - Running setup.py install for mozinfo 04:08:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:08:41 INFO - Running setup.py install for mozInstall 04:08:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:08:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:08:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:08:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:08:41 INFO - Running setup.py install for mozleak 04:08:41 INFO - Running setup.py install for mozlog 04:08:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:08:41 INFO - Running setup.py install for moznetwork 04:08:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:08:41 INFO - Running setup.py install for mozprocess 04:08:41 INFO - Running setup.py install for mozprofile 04:08:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:08:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:08:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:08:42 INFO - Running setup.py install for mozrunner 04:08:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:08:42 INFO - Running setup.py install for mozscreenshot 04:08:42 INFO - Running setup.py install for moztest 04:08:42 INFO - Running setup.py install for mozversion 04:08:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:08:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:08:42 INFO - Cleaning up... 04:08:42 INFO - Return code: 0 04:08:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:08:42 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')]} 04:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:42 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')]} 04:08:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:42 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 0x108762a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087694c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff44344da30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108606d30>, '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 0x10846adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085fdb20>, '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.Dg5QJn5r7a/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.Y2E1dIrdav/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 04:08:42 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 04:08:42 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 04:08:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dg5QJn5r7a/Render', 04:08:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:42 INFO - 'HOME': '/Users/cltbld', 04:08:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:42 INFO - 'LOGNAME': 'cltbld', 04:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:42 INFO - 'MOZ_NO_REMOTE': '1', 04:08:42 INFO - 'NO_EM_RESTART': '1', 04:08:42 INFO - 'PAGER': '/bin/cat', 04:08:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:42 INFO - 'PWD': '/builds/slave/test', 04:08:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:42 INFO - 'SHELL': '/bin/bash', 04:08:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y2E1dIrdav/Listeners', 04:08:42 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 04:08:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:42 INFO - 'USER': 'cltbld', 04:08:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:42 INFO - 'XPC_FLAGS': '0x0', 04:08:42 INFO - 'XPC_SERVICE_NAME': '0', 04:08:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:08:42 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-yIKOFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:08:43 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)) 04:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:08:43 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-LJcC3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:08:43 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)) 04:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:08:43 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-hAmTP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:08:43 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)) 04:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:08:43 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-TMhgoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:08:43 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)) 04:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:08:43 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-kO2NRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:08:43 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)) 04:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:08:43 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-BkT_dP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:08:43 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)) 04:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:08:43 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-Ue3TOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:08:43 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)) 04:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:08:43 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-aAbtGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:08:43 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)) 04:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:08:43 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-Th_CBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:08:43 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)) 04:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:08:43 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-wY9Psa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:08:44 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)) 04:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:08:44 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-_Sh3jt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:08:44 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)) 04:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:08:44 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-sIK0SP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:08:44 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)) 04:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:08:44 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-nLC2nn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:08:44 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)) 04:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:08:44 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-hMWjSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:08:44 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)) 04:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:44 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-lXT3AU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:44 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)) 04:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:08:44 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-kOWsDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:08:44 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)) 04:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:08:44 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-g8SSmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:08:44 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)) 04:08:44 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)) 04:08:44 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)) 04:08:44 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)) 04:08:44 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)) 04:08:44 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)) 04:08:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:08:44 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 04:08:44 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 04:08:44 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 04:08:44 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 04:08:44 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 04:08:44 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 04:08:48 INFO - Downloading blessings-1.6.tar.gz 04:08:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:08:48 INFO - Installing collected packages: blessings 04:08:48 INFO - Running setup.py install for blessings 04:08:48 INFO - Successfully installed blessings 04:08:48 INFO - Cleaning up... 04:08:48 INFO - Return code: 0 04:08:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:08:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:08:48 INFO - Reading from file tmpfile_stdout 04:08:48 INFO - Current package versions: 04:08:48 INFO - blessings == 1.6 04:08:48 INFO - blobuploader == 1.2.4 04:08:48 INFO - docopt == 0.6.1 04:08:48 INFO - manifestparser == 1.1 04:08:48 INFO - mozInstall == 1.12 04:08:48 INFO - mozcrash == 0.17 04:08:48 INFO - mozdebug == 0.1 04:08:48 INFO - mozdevice == 0.48 04:08:48 INFO - mozfile == 1.2 04:08:48 INFO - mozhttpd == 0.7 04:08:48 INFO - mozinfo == 0.9 04:08:48 INFO - mozleak == 0.1 04:08:48 INFO - mozlog == 3.1 04:08:48 INFO - moznetwork == 0.27 04:08:48 INFO - mozprocess == 0.22 04:08:48 INFO - mozprofile == 0.28 04:08:48 INFO - mozrunner == 6.11 04:08:48 INFO - mozscreenshot == 0.1 04:08:48 INFO - mozsystemmonitor == 0.0 04:08:48 INFO - moztest == 0.7 04:08:48 INFO - mozversion == 1.4 04:08:48 INFO - psutil == 3.1.1 04:08:48 INFO - requests == 1.2.3 04:08:48 INFO - wsgiref == 0.1.2 04:08:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:48 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 0x108762a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087694c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff44344da30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108606d30>, '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 0x10846adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085fdb20>, '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.Dg5QJn5r7a/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.Y2E1dIrdav/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 04:08:48 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 04:08:48 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 04:08:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dg5QJn5r7a/Render', 04:08:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:48 INFO - 'HOME': '/Users/cltbld', 04:08:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:48 INFO - 'LOGNAME': 'cltbld', 04:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:48 INFO - 'MOZ_NO_REMOTE': '1', 04:08:48 INFO - 'NO_EM_RESTART': '1', 04:08:48 INFO - 'PAGER': '/bin/cat', 04:08:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:48 INFO - 'PWD': '/builds/slave/test', 04:08:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:48 INFO - 'SHELL': '/bin/bash', 04:08:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y2E1dIrdav/Listeners', 04:08:48 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 04:08:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:48 INFO - 'USER': 'cltbld', 04:08:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:48 INFO - 'XPC_FLAGS': '0x0', 04:08:48 INFO - 'XPC_SERVICE_NAME': '0', 04:08:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:49 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)) 04:08:49 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)) 04:08:49 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)) 04:08:49 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)) 04:08:49 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)) 04:08:49 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)) 04:08:49 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)) 04:08:49 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)) 04:08:49 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)) 04:08:49 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)) 04:08:49 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)) 04:08:49 INFO - Cleaning up... 04:08:49 INFO - Return code: 0 04:08:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:08: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')]} 04:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08: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')]} 04:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108762a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087694c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff44344da30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108606d30>, '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 0x10846adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085fdb20>, '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.Dg5QJn5r7a/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.Y2E1dIrdav/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 04:08: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', 'jsonschema'] in /builds/slave/test/build 04:08: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 jsonschema 04:08:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dg5QJn5r7a/Render', 04:08:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:49 INFO - 'HOME': '/Users/cltbld', 04:08:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:49 INFO - 'LOGNAME': 'cltbld', 04:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:49 INFO - 'MOZ_NO_REMOTE': '1', 04:08:49 INFO - 'NO_EM_RESTART': '1', 04:08:49 INFO - 'PAGER': '/bin/cat', 04:08:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:49 INFO - 'PWD': '/builds/slave/test', 04:08:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:49 INFO - 'SHELL': '/bin/bash', 04:08:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y2E1dIrdav/Listeners', 04:08:49 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 04:08:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:49 INFO - 'USER': 'cltbld', 04:08:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:49 INFO - 'XPC_FLAGS': '0x0', 04:08:49 INFO - 'XPC_SERVICE_NAME': '0', 04:08:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:49 INFO - Downloading/unpacking jsonschema 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:08:51 INFO - Downloading/unpacking functools32 (from jsonschema) 04:08:51 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 04:08:51 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 04:08:51 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 04:08: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 04:08: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 04:08: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 04:08:52 INFO - Downloading functools32-3.2.3-2.tar.gz 04:08:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:08:52 INFO - warning: no files found matching '*.txt' 04:08:52 INFO - no previously-included directories found matching 'build' 04:08:52 INFO - no previously-included directories found matching 'dist' 04:08:52 INFO - no previously-included directories found matching '.git*' 04:08:52 INFO - Installing collected packages: jsonschema, functools32 04:08:52 INFO - Running setup.py install for functools32 04:08:52 INFO - warning: no files found matching '*.txt' 04:08:52 INFO - no previously-included directories found matching 'build' 04:08:52 INFO - no previously-included directories found matching 'dist' 04:08:52 INFO - no previously-included directories found matching '.git*' 04:08:52 INFO - Successfully installed jsonschema functools32 04:08:52 INFO - Cleaning up... 04:08:52 INFO - Return code: 0 04:08:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:08:52 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')]} 04:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:52 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')]} 04:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:52 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 0x108762a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087694c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff44344da30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108606d30>, '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 0x10846adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085fdb20>, '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.Dg5QJn5r7a/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.Y2E1dIrdav/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 04:08:52 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 04:08:52 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 04:08:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dg5QJn5r7a/Render', 04:08:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:52 INFO - 'HOME': '/Users/cltbld', 04:08:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:52 INFO - 'LOGNAME': 'cltbld', 04:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:52 INFO - 'MOZ_NO_REMOTE': '1', 04:08:52 INFO - 'NO_EM_RESTART': '1', 04:08:52 INFO - 'PAGER': '/bin/cat', 04:08:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:52 INFO - 'PWD': '/builds/slave/test', 04:08:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:52 INFO - 'SHELL': '/bin/bash', 04:08:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y2E1dIrdav/Listeners', 04:08:52 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 04:08:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:52 INFO - 'USER': 'cltbld', 04:08:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:52 INFO - 'XPC_FLAGS': '0x0', 04:08:52 INFO - 'XPC_SERVICE_NAME': '0', 04:08:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:53 INFO - Downloading/unpacking flake8 04:08:53 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 04:08:53 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 04:08:53 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 04:08:53 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 04:08:53 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 04:08:53 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 04:08:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:08:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:08:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:08:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:08:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:08:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:08:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:08:56 INFO - no previously-included directories found matching 'docs/_build' 04:08:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:08:57 INFO - Running setup.py install for pep8 04:08:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:08:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:08:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:08:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:08:57 INFO - no previously-included directories found matching 'docs/_build' 04:08:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:08:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:08:57 INFO - Cleaning up... 04:08:57 INFO - Return code: 0 04:08:57 INFO - Running post-action listener: _resource_record_post_action 04:08:57 INFO - Running post-action listener: _start_resource_monitoring 04:08:57 INFO - Starting resource monitoring. 04:08:57 INFO - ##### 04:08:57 INFO - ##### Running install step. 04:08:57 INFO - ##### 04:08:57 INFO - Running pre-action listener: _resource_record_pre_action 04:08:57 INFO - Running main action method: install 04:08:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:08:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:08:57 INFO - Reading from file tmpfile_stdout 04:08:57 INFO - Detecting whether we're running mozinstall >=1.0... 04:08:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:08:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:08:57 INFO - Reading from file tmpfile_stdout 04:08:57 INFO - Output received: 04:08:57 INFO - Usage: mozinstall [options] installer 04:08:57 INFO - Options: 04:08:57 INFO - -h, --help show this help message and exit 04:08:57 INFO - -d DEST, --destination=DEST 04:08:57 INFO - Directory to install application into. [default: 04:08:57 INFO - "/builds/slave/test"] 04:08:57 INFO - --app=APP Application being installed. [default: firefox] 04:08:57 INFO - mkdir: /builds/slave/test/build/application 04:08:57 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'] 04:08:57 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 04:09:20 INFO - Reading from file tmpfile_stdout 04:09:20 INFO - Output received: 04:09:20 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 04:09:20 INFO - Running post-action listener: _resource_record_post_action 04:09:20 INFO - ##### 04:09:20 INFO - ##### Running run-tests step. 04:09:20 INFO - ##### 04:09:20 INFO - Running pre-action listener: _resource_record_pre_action 04:09:20 INFO - Running main action method: run_tests 04:09:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:09:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:09:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:09:20 INFO - 2016-05-11 04:09:20.262 screenresolution[1941:10708] starting screenresolution argv=screenresolution get 04:09:20 INFO - 2016-05-11 04:09:20.264 screenresolution[1941:10708] Display 0: 1600x1200x32@60 04:09:20 INFO - 2016-05-11 04:09:20.270 screenresolution[1942:10711] starting screenresolution argv=screenresolution list 04:09:20 INFO - Available Modes on Display 0 04:09:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:09:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:09:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:09:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:09:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:09:20 INFO - Intel Iris: 04:09:20 INFO - Chipset Model: Intel Iris 04:09:20 INFO - Type: GPU 04:09:20 INFO - Bus: Built-In 04:09:20 INFO - VRAM (Dynamic, Max): 1536 MB 04:09:20 INFO - Vendor: Intel (0x8086) 04:09:20 INFO - Device ID: 0x0a2e 04:09:20 INFO - Revision ID: 0x0009 04:09:20 INFO - Displays: 04:09:20 INFO - Display: 04:09:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:09:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:09:20 INFO - Display Serial Number: 1600x1200 60 04:09:20 INFO - Main Display: Yes 04:09:20 INFO - Mirror: Off 04:09:20 INFO - Online: Yes 04:09:20 INFO - Rotation: Supported 04:09:20 INFO - Return code: 0 04:09:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:09:20 INFO - Python 2.7.3 04:09:20 INFO - Return code: 0 04:09:20 INFO - grabbing minidump binary from tooltool 04:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:20 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 0x108606d30>, '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 0x10846adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085fdb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:09:20 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 04:09:20 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 04:09:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:09:20 INFO - Return code: 0 04:09:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:09:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:09:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:09:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:09:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:09:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:09:21 INFO - Return code: 0 04:09:21 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/EZxbnFY2RleldqUphQOzRQ/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0111', '--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 04:09:21 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/EZxbnFY2RleldqUphQOzRQ/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0111 --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 04:09:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dg5QJn5r7a/Render', 04:09:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:09:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:09:21 INFO - 'HOME': '/Users/cltbld', 04:09:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:09:21 INFO - 'LOGNAME': 'cltbld', 04:09:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:09:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:21 INFO - 'MOZ_NO_REMOTE': '1', 04:09:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:09:21 INFO - 'NO_EM_RESTART': '1', 04:09:21 INFO - 'PAGER': '/bin/cat', 04:09:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:21 INFO - 'PWD': '/builds/slave/test', 04:09:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:09:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:09:21 INFO - 'SHELL': '/bin/bash', 04:09:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Y2E1dIrdav/Listeners', 04:09:21 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 04:09:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:09:21 INFO - 'USER': 'cltbld', 04:09:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:09:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:21 INFO - 'XPC_FLAGS': '0x0', 04:09:21 INFO - 'XPC_SERVICE_NAME': '0', 04:09:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:09:21 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/EZxbnFY2RleldqUphQOzRQ/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0111', '--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 04:09:21 INFO - mozversion application_buildid: 20160511020936 04:09:21 INFO - mozversion application_changeset: a4a650440913082f894933d142b68d3d16ec1abb 04:09:21 INFO - mozversion application_display_name: Firefox 04:09:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:09:21 INFO - mozversion application_name: Firefox 04:09:21 INFO - mozversion application_remotingname: firefox 04:09:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:09:21 INFO - mozversion application_vendor: Mozilla 04:09:21 INFO - mozversion application_version: 47.0 04:09:21 INFO - mozversion platform_buildid: 20160511020936 04:09:21 INFO - mozversion platform_changeset: a4a650440913082f894933d142b68d3d16ec1abb 04:09:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:09:21 INFO - mozversion platform_version: 47.0 04:09:21 INFO - using testdate: 1462964961 04:09:21 INFO - actual date: 1462964961 04:09:21 INFO - starting webserver on 'localhost:49663' 04:09:21 INFO - SUITE-START | Running 2 tests 04:09:21 INFO - TEST-START | dromaeo_css 04:09:21 INFO - operating with platform_type : mac_ 04:09:21 INFO - Initialising browser for dromaeo_css test... 04:09:22 INFO - TEST-INFO | started process 1960 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmptktDda/profile http://localhost:49663/getInfo.html) 04:09:24 INFO - PROCESS | 1960 | __metrics Screen width/height:1600/1200 04:09:24 INFO - PROCESS | 1960 | colorDepth:24 04:09:24 INFO - PROCESS | 1960 | Browser inner width/height: 1024/689 04:09:24 INFO - PROCESS | 1960 | __metrics 04:09:24 ERROR - PROCESS | 1960 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 04:09:25 INFO - TEST-INFO | 1960: exit 0 04:09:25 INFO - Browser initialized. 04:09:25 INFO - Running cycle 1/1 for dromaeo_css test... 04:09:25 INFO - TEST-INFO | started process 1964 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmptktDda/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:09:37 INFO - PROCESS | 1964 | RSS: Main: 168312832 04:09:37 INFO - PROCESS | 1964 | 04:10:26 INFO - PROCESS | 1964 | 1462965026819 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] 04:12:38 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49663/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49663/tests/dromaeo/cssquery-ext.html) 04:12:39 INFO - PROCESS | 1964 | RSS: Main: 178393088 04:12:39 INFO - PROCESS | 1964 | 04:15:41 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49663/tests/dromaeo/cssquery-ext.html (next: http://localhost:49663/tests/dromaeo/cssquery-jquery.html) 04:15:41 INFO - PROCESS | 1964 | RSS: Main: 190611456 04:15:41 INFO - PROCESS | 1964 | 04:18:43 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49663/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49663/tests/dromaeo/cssquery-mootools.html) 04:18:44 INFO - PROCESS | 1964 | RSS: Main: 191844352 04:18:44 INFO - PROCESS | 1964 | 04:21:45 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49663/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49663/tests/dromaeo/cssquery-prototype.html) 04:21:46 INFO - PROCESS | 1964 | RSS: Main: 195190784 04:21:46 INFO - PROCESS | 1964 | 04:24:48 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49663/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49663/tests/dromaeo/cssquery-yui.html) 04:24:49 INFO - PROCESS | 1964 | RSS: Main: 194478080 04:24:49 INFO - PROCESS | 1964 | 04:27:51 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:49663/tests/dromaeo/cssquery-yui.html (next: http://localhost:49663/tests/dromaeo/cssquery-dojo.html) 04:27:51 INFO - PROCESS | 1964 | RSS: Main: 200892416 04:27:51 INFO - PROCESS | 1964 | 04:27:51 INFO - PROCESS | 1964 | __start_tp_report 04:27:51 INFO - PROCESS | 1964 | _x_x_mozilla_page_load 04:27:51 INFO - PROCESS | 1964 | _x_x_mozilla_page_load_details 04:27:51 INFO - PROCESS | 1964 | |i|pagename|runs| 04:27:51 INFO - PROCESS | 1964 | |0;dojo.html;3447.2588393495403;3690.9815450922724;3694.501242332288;3739.1399978005056;3749.5500539935197;6036.275646922375;6054.243219597551;6062.757489700418;6067.211262535875;6085.8174254772375;6063.514918806496;6064.595926347084;6124.727153123165;6127.724252408641;6133.969330153343;5404.135338345865;5407.297051383314;5421.457854214586;5479.726013699299;5518.696471694056;5331.360236771593;5430.864228394302;5449.809256676017;5454.61817672763;5460.590455715817;5386.703731294777;5401.837944861641;5430.402655707869;5437.673739575618;5452.781888724447;5452.372977107644;5476.7535460904355;5498.972505137469;5503.724813759296;5542.528885044776;5358.33020872391;5441.455854414567;5448.754806033738;5481.643693159932;5528.75120619569;5790.218320526717;5800.593958422912;5846.970765146147;5860.531157507389;6098.57309988301;6324.33594472583;6363.109164716943;6370.394812492806;6382.393672601142;6389.7763578275;5658.924804287172;6434.581752186093;6446.935530644727;6448.45188159007;6451.29035806061;5719.48524632785;6073.605215660968;6137.693115344215;6180.443760061616;6227.408396202353;5495.642783219078;5720.513756330759;6552.115464412339;6552.50856185788;6567.9671601641685;6122.234720659918;6328.462080723098;6331.2085989251345;6351.936480635227;6352.745890164341;6306.3378345274;6417.903731444032;6478.935210647927;6524.934750652527;6535.346465353522;6349;6366.745330186834;6408.231012278557;6416.422521973045;6426.132472116298;6223.782167624111;6360.0777887206095;6414.839629009219;6420.678966051679;6443.130177426081;5103.668261562986;5170.534651881274;5175.689458632494;5179;5219.086659834514;4627.074585082997;4640.79116439761;4645.187092258841;4676.3453116563705;4696.60078893291;6120.510359171256;6131.284916201153;6142.815715528542;6170.598911070766;6198.659073750897;6283.8114856554375;6376.075469056961;6420.390062944013;6481.351864813575;6501.544891857525;6196.659183744847;6202.689865506707;6211.751529938842;6215.192025036717;6231.065340199007;5532.446755324516;5587.469190426903;5710.486056254957;5737.3688894221605;5745.741441635137;6651.368120028589;6676.365745254193;6691.7323307068145;6711.362420570135;6723.966380168068;6391.32891046452;6393.392627700361;6394.71223794921;6411.583247089111;6425.10048593188;6473.967630161819;6531.738730450728;6610.140681711539;6630.635315057718;6714.160729908762;6327.620342779448;6340.587861788969;6344.016677415008;6345;6345.111684364285;6383.170187875732;6391.392817682313;6422.357764223727;6431.678416079271;6440.355964403522;5505.394406615349;6201.720922558586;6264.59280146789;6266.27937787142;6296.181496405438;6278.121063051268;6293.96853015732;6299.590526615755;6300.180976473029;6304.621722696653;6058.57589968698;6257.061440783918;6311.715972781328;6331.2085989251345;6346.01636746305;6199.876002480015;6214.067889816563;6266.248050234001;6270.686465676789;6331.3352098029045;6290.370962903856;6293.622382657055;6294.905576416449;6302.3067462578165;6314.179156709598 04:27:51 INFO - PROCESS | 1964 | |1;ext.html;503.0542579949694;531.4393315052621;593.821264789393;651.5862427358629;678.5148618737602;36861;38919.80540097299;39704.20591588166;39735.2052958941;39736.801315993376;41248.79375603118;41759.791201043954;41784.95537611553;41871.79064104683;41874.58125418745;8599.269062129726;9306.62773489063;11897.821532676973;12057.397130143501;12073.818892716616;11904.940475297612;11992.940035299811;12113.091518136174;12138.15032947694;12207.084468664842;11998.460069296903;12027.45876435558;12149.088818338616;12346.444410001526;12349.629511114681;10314.329568578056;10869.402182879938;11723.76552468946;12035.578754743541;12153.392330383489;10373.377597344184;11955.462004209832;11983.46074426653;12262.632121036384;12350.691232719164;42241.788791056155;42260.36609450861;42449.36325955113;42586.57413425857;42600;3355.060583036729;3380.2732412531177;3447.293304872495;3537.7877327360184;3766;28254;28996.565051524245;29091.56362654562;29160.854195729098;30866.537001944987;2362.822788290885;2791.232411086947;2850.957235641467;2853.5862299966598;2892.3781387001686;495089;495887;496634;498290.50854745856;502496;67964.6601766988;68481.63036739237;69053.65473172603;69266;69443;72188;72561.2743872565;72666.90999635009;72667.63666181636;73069.6346518264;15805.683886322438;17245.913770431318;18520;19113;19344.032798360306;14008.579742607739;14275.214863182624;14311.284435778169;14366.712665746627;14370.425182992773;17055.31778728862;20157.891315977467;20262.290819821235;20408.18367265293;20453.897730511253;8735.737927862174;8885.955570222108;8888.288936885034;8898.688545900992;8923.241524470362;991.4546999150439;1031.339942436841;1100.312304809494;1163.9301641901513;1190.3155685480883;30143.397132057235;30207.244818879703;30359.696403036127;30846.228844279074;30953.45232738354;1180.2977228549;1182.9526818927318;1216.7627312674122;1223.1132428988913;1246.6571692784376;13870.237136957363;15621.843781562266;15754.527364179094;15788;15872.92063539675;515842;519207;521779.3911030496;526141;530622;61283.08075378873;62529.68735156386;62638.373616263256;62649.68675156595;62738.686306568175;1541.961450963735;1563.8357972412732;1578.2503310927218;1583.4141367694026;1592.4267263785027;29672.851635741685;30937;30969.8451507741;31139.377212455172;31782.52326215155;56988.43011569831;57394;57894.710526447096;57999.42000580109;58074.41925580859;407062;411555;413766;413782;414756;33784.49323260202;34649;34695.82652086723;35046.47430288599;35076.947691569294;43629.56370436255;43743.56256437522;44160.77919610382;44223.77888110668;44313.77843110764;35009.64990350064;36383;36485.817570911975;36749.63250367462;36930.44604330991;29964.400711985203;35718.64281357153;35739.46390804192;36018.8199059003;36235.818820905726;29471.85264073666;34697.306053879285;36947;37198.070048249014;37240.44139337966;33177.668223318426;33810.15474613154;33891;33919.321613567095;34149.48775768316;25120;25474.14094758253;25510.36224094338;26027.73972260253;26071.60892586575 04:27:51 INFO - PROCESS | 1964 | |2;jquery.html;341.3207716643876;368.1532475306794;376.27003612990796;379.6469283566284;380.41796052040377;20725.68911466329;20910.581788364223;21396.25113121041;21817.563648727017;21829.126834926603;20545.075471603777;21278.787212127874;22808.201712940052;23089.538209235805;23135.30594082176;5315.787368505275;5342.198670199472;5499.780008799643;5512.503874651281;5528.44715528446;5405.864853378657;5408.134698448249;5489.533389661883;5510.311211098613;5512.503874651281;5390.838274851761;5397.4062853086125;5486.780528778844;5507.870886468264;5523.972380138093;5542;5965.970170149165;5983.700814959257;6126.540509461808;6132.294786099611;5288.312519372495;5356.7857285708915;5372.54333381663;5377.489138531833;5392.892142157135;13069.01982351318;13588.93205533966;13627.705367990025;13627.931860340734;13664.453421863114;2170.511634882155;2319.7216334039854;2323.581755284048;2467.753224677536;2547.5669136246884;9752.317337786359;9910.306278560503;9938.751531211705;10315.742106447324;10456.63401780934;1762.7091529897552;1763.444514977778;1768.8938663680092;1837.5681714797013;1851.9536461898983;98038.50980745051;103629;106190.46904765426;107387.46306268418;107417.92582074157;10789.56841726338;11300.248461488482;11994.760104797855;12002.979746721627;12163.148579599343;14727.337269822669;14798;14864.256787160599;14884;14909.925450372679;7774.611269436506;9196.816063678823;9338.252939764803;9359.625614975324;9376;9422.481763503074;9546.904530954602;9559.808803823884;9586.808263834824;9641.42151470914;3759.793211373401;3833.4824798652385;4647.721136731807;4679.555442232982;4752.144613969519;1934.4100049484762;1981.643304205228;1994.1923520974028;2032.5833204193104;2038.979610203879;962.7015625156224;1006.285537268533;1024.4263212600968;1058.772363941756;1141.5833220874322;17175.398861039805;21670.674939875913;21675.566488670138;21778.564428711335;21795.59570863916;854.2183901729971;922.0318665401302;988.5452691761726;1028.3161697471248;1109.3011402816173;6054.212952316171;6476.384743449365;9200.6779762708;11461.255018423775;11558.595449159238;404150;518390;591616;641918;662237;105371.47314263532;107336.46331768291;114012;116318;121559.78440215661;477.7826089129438;488.10920070870094;489.1732971278528;489.2367906066548;492.5419359995239;11400.144989125683;11404.600838970597;11500.654980350602;11843.881561184622;11955.820662690241;36648.63351366452;50599.49400505948;52602.73698631483;54476.45523544714;57458;73370.89943650956;73953;75761.10597234893;76999.61500192463;78712.21287787278;8267.669293228204;8284.627191776264;8511.616977236163;8567.228949394585;8584.184502472255;9713.271504637321;13507.324633768076;13817.032807703365;13986.608035178811;14039.719205616035;11893.226940249202;12122.27266364021;12163.966062884754;12218.389080546114;12218.572349967708;9570.47362395075;10631.468426578485;11914.702132446759;11952.402379881145;12045.879541204476;11745.354005529778;12007.75984480288;12092.274463532216;12213.572524961939;12574.685632859251;7130.607816570138;8347.666093356198;8618.893089999841;8665.2634526066;8673.176048275403;9207.40151890125;10317.48412579353;12156.027517798731;12242;12374.010079193464 04:27:51 INFO - PROCESS | 1964 | |3;mootools.html;1668.949931502055;1681.285453682185;1753.4301352060575;2102.8317734581233;2132.477543001965;8351.95824020879;9058.592363343649;9147.862782058266;9281.257499400048;9348.439093654386;7619.619019049053;9087.136722011399;9165.816683666322;9181.724548263563;9190.678326258583;2509.1970569417795;2536.2898388451263;2550.642909992593;2550.8086893483064;2556.7698907098356;2532.1896992962165;2602.258356368435;2607.3220962549685;2614.372550587864;2634.894604215829;2567;2585.121058839994;2598.5062838060803;2616.463624956889;2623.435961268327;2208.7349518057777;2330.4406942333717;2541.4535874786825;2573.395252115751;2606.569915963864;2572.5626643470655;2580.1743442098536;2591.922242332733;2595.3641357867446;2608.6869575650853;9317.301202409779;9340.065993400674;9342.346035777498;9346.859797103049;9360.204382627484;5731.455511726421;5762.394948530386;5774.913376299359;5812.854678633025;5885;3625.9818700906326;3735.477033215352;3737.121776382548;3794.1083845296334;3794.8861534153743;1066.5520481397832;1088.314361951973;1091.7161538000098;1099.6646022962993;1122.2480937771713;12566.120371573994;12638.368081595883;12662.050346223978;12662.620121396372;12664.36678166088;4991.425986011583;5059.392872855207;5107.157319042316;5132.153194722829;5150.201718733602;10658.253922225369;10688.51901664427;10689.572417103229;10701.357918524913;10702.143828493858;5672.120821272627;5749.453801888814;5805.854853628609;5828.475437210586;5829.970850145722;4733.934864655425;5063;5183.2743415921805;5184.585233181337;5251.133562962068;4074.5942649785775;4160.292750232407;4168.583141685807;4189.539150693421;4195.748255104703;1354.2754626274896;1370.6093763277418;1373.7676276051416;1378.7035787305576;1381.5855243426931;1410.5697762182633;1428.5928510374702;1438.0365155345944;1461.5103940179947;1491.172399318367;8542.615582298688;8573.871391929126;8598.699045533376;8631.395802293904;8658.307335413152;533.2454576773822;543.3915609795051;548.3392512023003;548.9780408783604;554.9833504994857;6265.655388953652;6326.557141000178;6362.586431881913;6410.935890641033;6473.2232132144445;11048.447577621087;11119.888801112047;11260;11420.14348923834;11437.599684011186;10842.295250808673;10955.83566246507;11110.166737494721;11174.38540880243;11361.488733007034;8677.56612169389;8733.475991440408;8788.692395766118;8791.868121978176;8882.467051976902;8060;8141.470804397695;8190;8222.97212848394;8291.295239904435;9554.140127388568;9799.902000979899;10011.399316041061;10057.647982320585;10271.794564108526;9884.505774711379;10013.39919604826;10018.248631352824;10033.548490318099;10242.590296388062;7574.5076570022775;7760.495567788075;7766.728164514215;7815.25755053269;7823.726169584037;8501.914980850112;8679.349048821237;8722.433041852259;8724.476531408136;8734.257588105082;7550.509216900884;7665;7703.268189521987;7745.302922736981;7829.882551761614;7400.629968501661;7496.475246732676;7504.437167212372;7637.198094200029;7638.885416718643;7973.561454120079;7993.320567751573;8061.0326760789085;8099.83800324002;8174.223448772357;7231.204567497676;7353.338199562065;7363.226861179499;7374.299441553044;7374.741884034033;7457.47797654159;7489.850202996018;7526.736564220226;7539.886901696369;7542.622868856645 04:27:51 INFO - PROCESS | 1964 | |4;prototype.html;295.7102040000799;335.08521735661645;338.4922616075886;339.90142858571;344.2924789557458;7018.298170182979;7060;7079.8584028319465;7102.218755936856;7122.074130363052;7060.1880783709885;7080.5397649152765;7088.184858741233;7095.751648692297;7118.822029449267;4944.554990050895;5015.5486006259425;5090.236464530313;5098;5209.583233341324;5071.087204303224;5092.185250359943;5107.7956881724685;5109.923351149736;5117.590592752589;5006.27409025691;5018.473060328668;5019.498050194969;5036.017976494585;5042.495750424965;5042.647014708972;5053.722045287508;5065.924011139836;5070.059365567961;5087.872803179932;4406.317020861771;4410.492793328776;4415.690901636886;4416.895776055986;4430.756308403036;6583.308752580958;6743.966280168568;6805.319468053204;6842.692078856463;6843.8973415398805;6044.214252147237;6084.908726369108;6088.4215999479975;6105.236845394325;6122.724477398528;7537.246275372474;7555;7556.206598307153;7563.357114645261;7568.394528437711;4612.677112602119;4974.925376119361;4990.950090499085;4994.675346102528;4995.5753760930365;6394.808155755335;7220.4584656151;7969.481983671043;7989.520628762293;8003.559804210766;4972.453030166679;5026.1204289249235;5027.748612569357;5051.4695956924725;5093.312402825645;4169.770662613525;5138.972205558904;5235.136202526616;5277.868053298698;5316.521513063843;6111.297200821962;6119.326874043852;6122.387761223842;6130.570860039755;6143.508519318444;6260.937390626126;7600.391968642495;7648.9617551913;7655.770326890202;7664.195259497673;1673.2470388325303;1733.800612929504;1782.189103957696;1811.5742800441885;1813.238439855264;1083.2525557365393;1084.951177197028;1103.6755892928518;1111.9110471162287;1113;5155.355580552431;5794.391588883191;6838.418734407532;7261.636918154071;7283.890741638879;7836.216378362118;7849.843003139905;7852.882206766903;7872.72445464406;7931.484453510619;7255.673494692752;7261.2012678605315;7277.017602623684;7278;7291.30732580404;3721.423179407196;3783.886483405502;4051.7366371186367;4059.289624315792;4154.210699966997;8089.635966381409;8253.463524870864;8266.545340006358;8332.916670833336;8383.203595658402;7435.85128297431;8219.671213151407;8236.341092712568;8252.298554622805;8256.669733210605;6781.423578995742;8307.08622051574;8357.373197010249;8364.958175209085;8373.037100733372;7748.418868584766;8006.879896801669;8010.239027292398;8017;8021.358291336795;7083.150021997393;7740;7774.067111946602;7831.960840195762;7843.8039049021945;8305.294050005576;8330.375221858507;8338.99932008163;8342;8356.075373619185;4126.834926602903;4913.459519452929;4927.975360123177;4961.479044700399;4975.875603109951;7726.806829829299;7858.882116768367;7873.291403773688;7889.13219545838;7967.322777563972;6201.534884883562;7651.196624354585;7676.193999629959;7679.308862202429;7682.347000505019;6923.723051077901;7648.579328137006;7651.1201211859125;7654.73208437702;7656.234376562299;7163.820904477429;7466.887996679946;7512.32389084985;7517.962410187914;7522.774316770506;7643;7649;7656.387489000978;7701.768946931601;7716.92283077162;7484.925150748641;7500.549967001997;7504.774856754306;7526.172121066569;7531.133919599316 04:27:51 INFO - PROCESS | 1964 | |5;yui.html;727.5162017258525;766.3409467857645;773.9458237923344;779.7738655789822;794.8728203487443;15571.22143892805;15817.60455988601;15853.445129420457;15854.04875707457;15878.444254451097;14672.26638668065;14689.706205875877;14763.188024658639;14770.852291477082;14796.482123125692;808.2200676347353;974.6491263145244;974.8342781727088;1007.7077647482222;1008.5915204342253;974.1135566634364;988.406955826502;990.4750482244386;990.8563258327538;992.1120597065658;1029.9124574411185;1041.2398948767404;1054.051353781595;1055.430067763407;1055.975703567542;1045.0333441566559;1045.8222102242637;1047.738065483629;1048.958041678332;1050.112654806687;764.3121190928154;783.1463704562054;784.6508303804809;793.111714879333;796.2992566541465;15012.924935375362;15115.31981060855;15165.545033649008;15175;15234.695306093927;11116.444177791078;13344.866551334557;13381.53164639233;13533.458661653522;13558.98307626932;10180.990980251914;10373.948130259301;10397.960203979617;10442.425666588335;10651.307665001828;3215.324781795826;3556.733245006609;3619.674229319374;3660.9932268626076;3708.870189543353;64179;81992;87451.56274218652;88691.66962495503;90482;8220.917790822015;9735.269854760922;9912.256580756472;9964.10323070927;10003.799924001625;18413.355532556296;20589.48526286825;20757.481062973246;22753.08987640509;23092.4226894329;7520.6239688015385;7686.423518236154;7689.346405555479;7709.922900770921;7760.417968652374;4104.507459104927;4128.422020917014;4169.728967617156;4235.152969406131;4283.100548884707;3221.4684577044995;3721.0883333583447;3779.338615742289;3781.3382658034734;3784.4701741756176;648.5913874259187;662.4733336997002;664.3522565498697;675.878341898463;690.5683947532792;603.1435361786274;616.4913945994573;621.3755176048043;623.4825095170997;628.5788521690479;8017.959910200411;8603.612837422332;8630.136986301446;8642.956785216034;8938.68714594986;562.1230879827482;566.7194738604417;615.4430240632234;627.3632263252802;635.1425575473166;3932.410138479251;3953.4267531207815;4015.678745700337;4065.7560546367313;4079.326911059642;89242.55378723064;89586;89683;91049.54475227582;91401.54299228461;63847.29831265789;78930.21069789343;82661.58669206615;83140.58429707812;83381.58309208415;76246.23753762503;76835.61582192164;77017.61491192508;77193.22806771973;77555.61222193853;6707.987603718767;7973.242541958504;8139.552324622203;8171.713990010321;8207.974003249594;51246.48753512566;51798;51934.961300773015;52013.47986520086;52050.73974630103;63914.680426597566;68750;72845;72925.90611140944;73438;10668.786624267315;10727;11358.94320528392;11552.422378880854;11768.35274059935;10243.59025638996;12219.572314968933;12325.69185770327;12570.937145314581;12880.742385152433;11689.766204676029;11786.705332366417;11787.292762434281;11792.351420671945;12368.072394570263;10273.229507786797;10352.430616316175;10367.896321036693;10701.250912436366;10734.785304294026;10711.571537138427;11348.262362946381;12003.39983000829;12056.397180140782;12088;9883.357581757164;9970.800583988424;10066.748331291776;10521.789564208826;10533.42066186367;10025.097741203326;10033.14718248957;10033.794897867772;10053.547590358305;10202.693919182437 04:27:51 INFO - PROCESS | 1964 | __end_tp_report 04:27:51 INFO - PROCESS | 1964 | __start_cc_report 04:27:51 INFO - PROCESS | 1964 | _x_x_mozilla_cycle_collect,355 04:27:52 INFO - PROCESS | 1964 | __end_cc_report 04:27:52 INFO - PROCESS | 1964 | __startTimestamp1462966071985__endTimestamp 04:27:52 INFO - PROCESS | 1964 | 04:27:52 INFO - PROCESS | 1964 | ------- Summary: start ------- 04:27:52 INFO - PROCESS | 1964 | Number of tests: 6 04:27:52 INFO - PROCESS | 1964 | 04:27:52 INFO - PROCESS | 1964 | [#0] dojo.html Cycles:165 Average:5978.45 Median:6223.78 stddev:625.21 (10.0%) stddev-sans-first:594.76 04:27:52 INFO - PROCESS | 1964 | Values: 3447.3 3691.0 3694.5 3739.1 3749.6 6036.3 6054.2 6062.8 6067.2 6085.8 6063.5 6064.6 6124.7 6127.7 6134.0 5404.1 5407.3 5421.5 5479.7 5518.7 5331.4 5430.9 5449.8 5454.6 5460.6 5386.7 5401.8 5430.4 5437.7 5452.8 5452.4 5476.8 5499.0 5503.7 5542.5 5358.3 5441.5 5448.8 5481.6 5528.8 5790.2 5800.6 5847.0 5860.5 6098.6 6324.3 6363.1 6370.4 6382.4 6389.8 5658.9 6434.6 6446.9 6448.5 6451.3 5719.5 6073.6 6137.7 6180.4 6227.4 5495.6 5720.5 6552.1 6552.5 6568.0 6122.2 6328.5 6331.2 6351.9 6352.7 6306.3 6417.9 6478.9 6524.9 6535.3 6349.0 6366.7 6408.2 6416.4 6426.1 6223.8 6360.1 6414.8 6420.7 6443.1 5103.7 5170.5 5175.7 5179.0 5219.1 4627.1 4640.8 4645.2 4676.3 4696.6 6120.5 6131.3 6142.8 6170.6 6198.7 6283.8 6376.1 6420.4 6481.4 6501.5 6196.7 6202.7 6211.8 6215.2 6231.1 5532.4 5587.5 5710.5 5737.4 5745.7 6651.4 6676.4 6691.7 6711.4 6724.0 6391.3 6393.4 6394.7 6411.6 6425.1 6474.0 6531.7 6610.1 6630.6 6714.2 6327.6 6340.6 6344.0 6345.0 6345.1 6383.2 6391.4 6422.4 6431.7 6440.4 5505.4 6201.7 6264.6 6266.3 6296.2 6278.1 6294.0 6299.6 6300.2 6304.6 6058.6 6257.1 6311.7 6331.2 6346.0 6199.9 6214.1 6266.2 6270.7 6331.3 6290.4 6293.6 6294.9 6302.3 6314.2 04:27:52 INFO - PROCESS | 1964 | 04:27:52 INFO - PROCESS | 1964 | [#1] ext.html Cycles:180 Average:63813.61 Median:34034.40 stddev:127277.72 (374.0%) stddev-sans-first:127546.01 04:27:52 INFO - PROCESS | 1964 | Values: 503.1 531.4 593.8 651.6 678.5 36861.0 38919.8 39704.2 39735.2 39736.8 41248.8 41759.8 41785.0 41871.8 41874.6 8599.3 9306.6 11897.8 12057.4 12073.8 11904.9 11992.9 12113.1 12138.2 12207.1 11998.5 12027.5 12149.1 12346.4 12349.6 10314.3 10869.4 11723.8 12035.6 12153.4 10373.4 11955.5 11983.5 12262.6 12350.7 42241.8 42260.4 42449.4 42586.6 42600.0 3355.1 3380.3 3447.3 3537.8 3766.0 28254.0 28996.6 29091.6 29160.9 30866.5 2362.8 2791.2 2851.0 2853.6 2892.4 495089.0 495887.0 496634.0 498290.5 502496.0 67964.7 68481.6 69053.7 69266.0 69443.0 72188.0 72561.3 72666.9 72667.6 73069.6 15805.7 17245.9 18520.0 19113.0 19344.0 14008.6 14275.2 14311.3 14366.7 14370.4 17055.3 20157.9 20262.3 20408.2 20453.9 8735.7 8886.0 8888.3 8898.7 8923.2 991.5 1031.3 1100.3 1163.9 1190.3 30143.4 30207.2 30359.7 30846.2 30953.5 1180.3 1183.0 1216.8 1223.1 1246.7 13870.2 15621.8 15754.5 15788.0 15872.9 515842.0 519207.0 521779.4 526141.0 530622.0 61283.1 62529.7 62638.4 62649.7 62738.7 1542.0 1563.8 1578.3 1583.4 1592.4 29672.9 30937.0 30969.8 31139.4 31782.5 56988.4 57394.0 57894.7 57999.4 58074.4 407062.0 411555.0 413766.0 413782.0 414756.0 33784.5 34649.0 34695.8 35046.5 35076.9 43629.6 43743.6 44160.8 44223.8 44313.8 35009.6 36383.0 36485.8 36749.6 36930.4 29964.4 35718.6 35739.5 36018.8 36235.8 29471.9 34697.3 36947.0 37198.1 37240.4 33177.7 33810.2 33891.0 33919.3 34149.5 25120.0 25474.1 25510.4 26027.7 26071.6 04:27:52 INFO - PROCESS | 1964 | 04:27:52 INFO - PROCESS | 1964 | [#2] jquery.html Cycles:180 Average:32730.14 Median:1444.44 stddev:95059.22 (6581.0%) stddev-sans-first:95294.77 04:27:52 INFO - PROCESS | 1964 | Values: 341.3 368.2 376.3 379.6 380.4 20725.7 20910.6 21396.3 21817.6 21829.1 20545.1 21278.8 22808.2 23089.5 23135.3 5315.8 5342.2 5499.8 5512.5 5528.4 5405.9 5408.1 5489.5 5510.3 5512.5 5390.8 5397.4 5486.8 5507.9 5524.0 5542.0 5966.0 5983.7 6126.5 6132.3 5288.3 5356.8 5372.5 5377.5 5392.9 13069.0 13588.9 13627.7 13627.9 13664.5 2170.5 2319.7 2323.6 2467.8 2547.6 9752.3 9910.3 9938.8 10315.7 10456.6 1762.7 1763.4 1768.9 1837.6 1852.0 98038.5 103629.0 106190.5 107387.5 107417.9 10789.6 11300.2 11994.8 12003.0 12163.1 14727.3 14798.0 14864.3 14884.0 14909.9 7774.6 9196.8 9338.3 9359.6 9376.0 9422.5 9546.9 9559.8 9586.8 9641.4 3759.8 3833.5 4647.7 4679.6 4752.1 1934.4 1981.6 1994.2 2032.6 2039.0 962.7 1006.3 1024.4 1058.8 1141.6 17175.4 21670.7 21675.6 21778.6 21795.6 854.2 922.0 988.5 1028.3 1109.3 6054.2 6476.4 9200.7 11461.3 11558.6 404150.0 518390.0 591616.0 641918.0 662237.0 105371.5 107336.5 114012.0 116318.0 121559.8 477.8 488.1 489.2 489.2 492.5 11400.1 11404.6 11500.7 11843.9 11955.8 36648.6 50599.5 52602.7 54476.5 57458.0 73370.9 73953.0 75761.1 76999.6 78712.2 8267.7 8284.6 8511.6 8567.2 8584.2 9713.3 13507.3 13817.0 13986.6 14039.7 11893.2 12122.3 12164.0 12218.4 12218.6 9570.5 10631.5 11914.7 11952.4 12045.9 11745.4 12007.8 12092.3 12213.6 12574.7 7130.6 8347.7 8618.9 8665.3 8673.2 9207.4 10317.5 12156.0 12242.0 12374.0 04:27:52 INFO - PROCESS | 1964 | 04:27:52 INFO - PROCESS | 1964 | [#3] mootools.html Cycles:180 Average:6336.39 Median:5217.86 stddev:3352.83 (64.3%) stddev-sans-first:3343.88 04:27:52 INFO - PROCESS | 1964 | Values: 1668.9 1681.3 1753.4 2102.8 2132.5 8352.0 9058.6 9147.9 9281.3 9348.4 7619.6 9087.1 9165.8 9181.7 9190.7 2509.2 2536.3 2550.6 2550.8 2556.8 2532.2 2602.3 2607.3 2614.4 2634.9 2567.0 2585.1 2598.5 2616.5 2623.4 2208.7 2330.4 2541.5 2573.4 2606.6 2572.6 2580.2 2591.9 2595.4 2608.7 9317.3 9340.1 9342.3 9346.9 9360.2 5731.5 5762.4 5774.9 5812.9 5885.0 3626.0 3735.5 3737.1 3794.1 3794.9 1066.6 1088.3 1091.7 1099.7 1122.2 12566.1 12638.4 12662.1 12662.6 12664.4 4991.4 5059.4 5107.2 5132.2 5150.2 10658.3 10688.5 10689.6 10701.4 10702.1 5672.1 5749.5 5805.9 5828.5 5830.0 4733.9 5063.0 5183.3 5184.6 5251.1 4074.6 4160.3 4168.6 4189.5 4195.7 1354.3 1370.6 1373.8 1378.7 1381.6 1410.6 1428.6 1438.0 1461.5 1491.2 8542.6 8573.9 8598.7 8631.4 8658.3 533.2 543.4 548.3 549.0 555.0 6265.7 6326.6 6362.6 6410.9 6473.2 11048.4 11119.9 11260.0 11420.1 11437.6 10842.3 10955.8 11110.2 11174.4 11361.5 8677.6 8733.5 8788.7 8791.9 8882.5 8060.0 8141.5 8190.0 8223.0 8291.3 9554.1 9799.9 10011.4 10057.6 10271.8 9884.5 10013.4 10018.2 10033.5 10242.6 7574.5 7760.5 7766.7 7815.3 7823.7 8501.9 8679.3 8722.4 8724.5 8734.3 7550.5 7665.0 7703.3 7745.3 7829.9 7400.6 7496.5 7504.4 7637.2 7638.9 7973.6 7993.3 8061.0 8099.8 8174.2 7231.2 7353.3 7363.2 7374.3 7374.7 7457.5 7489.9 7526.7 7539.9 7542.6 04:27:52 INFO - PROCESS | 1964 | 04:27:52 INFO - PROCESS | 1964 | [#4] prototype.html Cycles:180 Average:6179.68 Median:7070.02 stddev:2018.34 (28.5%) stddev-sans-first:1975.10 04:27:52 INFO - PROCESS | 1964 | Values: 295.7 335.1 338.5 339.9 344.3 7018.3 7060.0 7079.9 7102.2 7122.1 7060.2 7080.5 7088.2 7095.8 7118.8 4944.6 5015.5 5090.2 5098.0 5209.6 5071.1 5092.2 5107.8 5109.9 5117.6 5006.3 5018.5 5019.5 5036.0 5042.5 5042.6 5053.7 5065.9 5070.1 5087.9 4406.3 4410.5 4415.7 4416.9 4430.8 6583.3 6744.0 6805.3 6842.7 6843.9 6044.2 6084.9 6088.4 6105.2 6122.7 7537.2 7555.0 7556.2 7563.4 7568.4 4612.7 4974.9 4991.0 4994.7 4995.6 6394.8 7220.5 7969.5 7989.5 8003.6 4972.5 5026.1 5027.7 5051.5 5093.3 4169.8 5139.0 5235.1 5277.9 5316.5 6111.3 6119.3 6122.4 6130.6 6143.5 6260.9 7600.4 7649.0 7655.8 7664.2 1673.2 1733.8 1782.2 1811.6 1813.2 1083.3 1085.0 1103.7 1111.9 1113.0 5155.4 5794.4 6838.4 7261.6 7283.9 7836.2 7849.8 7852.9 7872.7 7931.5 7255.7 7261.2 7277.0 7278.0 7291.3 3721.4 3783.9 4051.7 4059.3 4154.2 8089.6 8253.5 8266.5 8332.9 8383.2 7435.9 8219.7 8236.3 8252.3 8256.7 6781.4 8307.1 8357.4 8365.0 8373.0 7748.4 8006.9 8010.2 8017.0 8021.4 7083.2 7740.0 7774.1 7832.0 7843.8 8305.3 8330.4 8339.0 8342.0 8356.1 4126.8 4913.5 4928.0 4961.5 4975.9 7726.8 7858.9 7873.3 7889.1 7967.3 6201.5 7651.2 7676.2 7679.3 7682.3 6923.7 7648.6 7651.1 7654.7 7656.2 7163.8 7466.9 7512.3 7518.0 7522.8 7643.0 7649.0 7656.4 7701.8 7716.9 7484.9 7500.5 7504.8 7526.2 7531.1 04:27:52 INFO - PROCESS | 1964 | 04:27:52 INFO - PROCESS | 1964 | [#5] yui.html Cycles:180 Average:18737.72 Median:4091.92 stddev:26330.22 (643.5%) stddev-sans-first:26369.35 04:27:52 INFO - PROCESS | 1964 | Values: 727.5 766.3 773.9 779.8 794.9 15571.2 15817.6 15853.4 15854.0 15878.4 14672.3 14689.7 14763.2 14770.9 14796.5 808.2 974.6 974.8 1007.7 1008.6 974.1 988.4 990.5 990.9 992.1 1029.9 1041.2 1054.1 1055.4 1056.0 1045.0 1045.8 1047.7 1049.0 1050.1 764.3 783.1 784.7 793.1 796.3 15012.9 15115.3 15165.5 15175.0 15234.7 11116.4 13344.9 13381.5 13533.5 13559.0 10181.0 10373.9 10398.0 10442.4 10651.3 3215.3 3556.7 3619.7 3661.0 3708.9 64179.0 81992.0 87451.6 88691.7 90482.0 8220.9 9735.3 9912.3 9964.1 10003.8 18413.4 20589.5 20757.5 22753.1 23092.4 7520.6 7686.4 7689.3 7709.9 7760.4 4104.5 4128.4 4169.7 4235.2 4283.1 3221.5 3721.1 3779.3 3781.3 3784.5 648.6 662.5 664.4 675.9 690.6 603.1 616.5 621.4 623.5 628.6 8018.0 8603.6 8630.1 8643.0 8938.7 562.1 566.7 615.4 627.4 635.1 3932.4 3953.4 4015.7 4065.8 4079.3 89242.6 89586.0 89683.0 91049.5 91401.5 63847.3 78930.2 82661.6 83140.6 83381.6 76246.2 76835.6 77017.6 77193.2 77555.6 6708.0 7973.2 8139.6 8171.7 8208.0 51246.5 51798.0 51935.0 52013.5 52050.7 63914.7 68750.0 72845.0 72925.9 73438.0 10668.8 10727.0 11358.9 11552.4 11768.4 10243.6 12219.6 12325.7 12570.9 12880.7 11689.8 11786.7 11787.3 11792.4 12368.1 10273.2 10352.4 10367.9 10701.3 10734.8 10711.6 11348.3 12003.4 12056.4 12088.0 9883.4 9970.8 10066.7 10521.8 10533.4 10025.1 10033.1 10033.8 10053.5 10202.7 04:27:52 INFO - PROCESS | 1964 | -------- Summary: end -------- 04:27:52 INFO - PROCESS | 1964 | 04:27:52 INFO - TEST-INFO | 1964: exit 0 04:27:52 INFO - TEST-OK | dromaeo_css | took 1110572ms 04:27:52 INFO - TEST-START | kraken 04:27:52 INFO - operating with platform_type : mac_ 04:27:52 INFO - Initialising browser for kraken test... 04:27:52 INFO - TEST-INFO | started process 1970 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpIjkvbK/profile http://localhost:49663/getInfo.html) 04:27:54 INFO - PROCESS | 1970 | __metrics Screen width/height:1600/1200 04:27:54 INFO - PROCESS | 1970 | colorDepth:24 04:27:54 INFO - PROCESS | 1970 | Browser inner width/height: 1024/689 04:27:54 INFO - PROCESS | 1970 | __metrics 04:27:55 ERROR - PROCESS | 1970 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 04:27:55 INFO - TEST-INFO | 1970: exit 0 04:27:55 INFO - Browser initialized. 04:27:55 INFO - Running cycle 1/1 for kraken test... 04:27:55 INFO - TEST-INFO | started process 1974 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpIjkvbK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:28:07 INFO - PROCESS | 1974 | RSS: Main: 167849984 04:28:07 INFO - PROCESS | 1974 | 04:28:10 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:49663/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49663/tests/kraken/driver.html?testName=audio-beat-detection) 04:28:10 INFO - PROCESS | 1974 | RSS: Main: 179838976 04:28:10 INFO - PROCESS | 1974 | 04:28:13 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:49663/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49663/tests/kraken/driver.html?testName=audio-dft) 04:28:14 INFO - PROCESS | 1974 | RSS: Main: 188870656 04:28:14 INFO - PROCESS | 1974 | 04:28:17 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:49663/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49663/tests/kraken/driver.html?testName=audio-fft) 04:28:17 INFO - PROCESS | 1974 | RSS: Main: 192303104 04:28:17 INFO - PROCESS | 1974 | 04:28:19 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:49663/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49663/tests/kraken/driver.html?testName=audio-oscillator) 04:28:20 INFO - PROCESS | 1974 | RSS: Main: 192839680 04:28:20 INFO - PROCESS | 1974 | 04:28:22 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:49663/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49663/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:28:23 INFO - PROCESS | 1974 | RSS: Main: 194355200 04:28:23 INFO - PROCESS | 1974 | 04:28:26 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:49663/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49663/tests/kraken/driver.html?testName=imaging-darkroom) 04:28:26 INFO - PROCESS | 1974 | RSS: Main: 194617344 04:28:26 INFO - PROCESS | 1974 | 04:28:29 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:49663/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49663/tests/kraken/driver.html?testName=imaging-desaturate) 04:28:30 INFO - PROCESS | 1974 | RSS: Main: 194535424 04:28:30 INFO - PROCESS | 1974 | 04:28:33 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:49663/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49663/tests/kraken/driver.html?testName=json-parse-financial) 04:28:33 INFO - PROCESS | 1974 | RSS: Main: 194633728 04:28:33 INFO - PROCESS | 1974 | 04:28:35 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:49663/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49663/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:28:35 INFO - PROCESS | 1974 | RSS: Main: 194301952 04:28:35 INFO - PROCESS | 1974 | 04:28:37 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:49663/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49663/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:28:38 INFO - PROCESS | 1974 | RSS: Main: 194277376 04:28:38 INFO - PROCESS | 1974 | 04:28:40 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:49663/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49663/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:28:40 INFO - PROCESS | 1974 | RSS: Main: 194457600 04:28:40 INFO - PROCESS | 1974 | 04:28:43 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:49663/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49663/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:28:44 INFO - PROCESS | 1974 | RSS: Main: 194629632 04:28:44 INFO - PROCESS | 1974 | 04:28:46 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:49663/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49663/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:28:47 INFO - PROCESS | 1974 | RSS: Main: 194822144 04:28:47 INFO - PROCESS | 1974 | 04:28:48 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:49663/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49663/tests/kraken/driver.html?testName=ai-astar) 04:28:48 INFO - PROCESS | 1974 | RSS: Main: 196337664 04:28:48 INFO - PROCESS | 1974 | 04:28:48 INFO - PROCESS | 1974 | __start_tp_report 04:28:48 INFO - PROCESS | 1974 | _x_x_mozilla_page_load 04:28:48 INFO - PROCESS | 1974 | _x_x_mozilla_page_load_details 04:28:48 INFO - PROCESS | 1974 | |i|pagename|runs| 04:28:48 INFO - PROCESS | 1974 | |0;ai-astar;118;111;116;115;115;131;116;116;117;114 04:28:48 INFO - PROCESS | 1974 | |1;audio-beat-detection;153;117;145;151;118;173;150;148;170;155 04:28:48 INFO - PROCESS | 1974 | |2;audio-dft;190;199;192;200;202;194;200;195;201;193 04:28:48 INFO - PROCESS | 1974 | |3;audio-fft;71;80;62;115;81;83;87;64;119;58 04:28:48 INFO - PROCESS | 1974 | |4;audio-oscillator;86;78;121;78;66;102;161;116;118;121 04:28:48 INFO - PROCESS | 1974 | |5;imaging-gaussian-blur;91;122;89;87;98;118;91;89;134;86 04:28:48 INFO - PROCESS | 1974 | |6;imaging-darkroom;95;113;152;96;97;116;151;123;96;95 04:28:48 INFO - PROCESS | 1974 | |7;imaging-desaturate;97;108;97;96;98;96;95;97;97;90 04:28:48 INFO - PROCESS | 1974 | |8;json-parse-financial;56;60;57;59;60;58;59;58;60;57 04:28:48 INFO - PROCESS | 1974 | |9;json-stringify-tinderbox;61;65;64;73;70;81;71;67;69;65 04:28:48 INFO - PROCESS | 1974 | |10;stanford-crypto-aes;84;81;85;81;84;84;83;81;83;86 04:28:48 INFO - PROCESS | 1974 | |11;stanford-crypto-ccm;127;123;130;119;119;118;116;123;128;138 04:28:48 INFO - PROCESS | 1974 | |12;stanford-crypto-pbkdf2;133;138;137;137;137;136;134;136;136;139 04:28:48 INFO - PROCESS | 1974 | |13;stanford-crypto-sha256-iterative;67;68;66;64;66;66;65;68;65;68 04:28:48 INFO - PROCESS | 1974 | __end_tp_report 04:28:48 INFO - PROCESS | 1974 | __start_cc_report 04:28:48 INFO - PROCESS | 1974 | _x_x_mozilla_cycle_collect,913 04:28:48 INFO - PROCESS | 1974 | __end_cc_report 04:28:48 INFO - PROCESS | 1974 | __startTimestamp1462966128905__endTimestamp 04:28:48 INFO - PROCESS | 1974 | 04:28:48 INFO - PROCESS | 1974 | ------- Summary: start ------- 04:28:48 INFO - PROCESS | 1974 | Number of tests: 14 04:28:48 INFO - PROCESS | 1974 | 04:28:48 INFO - PROCESS | 1974 | [#0] ai-astar Cycles:10 Average:116.90 Median:116.00 stddev:5.30 (4.6%) stddev-sans-first:5.61 04:28:48 INFO - PROCESS | 1974 | Values: 118.0 111.0 116.0 115.0 115.0 131.0 116.0 116.0 117.0 114.0 04:28:48 INFO - PROCESS | 1974 | 04:28:48 INFO - PROCESS | 1974 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:152.00 stddev:18.46 (12.1%) stddev-sans-first:19.49 04:28:48 INFO - PROCESS | 1974 | Values: 153.0 117.0 145.0 151.0 118.0 173.0 150.0 148.0 170.0 155.0 04:28:48 INFO - PROCESS | 1974 | 04:28:48 INFO - PROCESS | 1974 | [#2] audio-dft Cycles:10 Average:196.60 Median:199.50 stddev:4.27 (2.1%) stddev-sans-first:3.81 04:28:48 INFO - PROCESS | 1974 | Values: 190.0 199.0 192.0 200.0 202.0 194.0 200.0 195.0 201.0 193.0 04:28:48 INFO - PROCESS | 1974 | 04:28:48 INFO - PROCESS | 1974 | [#3] audio-fft Cycles:10 Average:82.00 Median:75.50 stddev:20.84 (27.6%) stddev-sans-first:21.72 04:28:48 INFO - PROCESS | 1974 | Values: 71.0 80.0 62.0 115.0 81.0 83.0 87.0 64.0 119.0 58.0 04:28:48 INFO - PROCESS | 1974 | 04:28:48 INFO - PROCESS | 1974 | [#4] audio-oscillator Cycles:10 Average:104.70 Median:113.50 stddev:28.45 (25.1%) stddev-sans-first:29.36 04:28:48 INFO - PROCESS | 1974 | Values: 86.0 78.0 121.0 78.0 66.0 102.0 161.0 116.0 118.0 121.0 04:28:48 INFO - PROCESS | 1974 | 04:28:48 INFO - PROCESS | 1974 | [#5] imaging-gaussian-blur Cycles:10 Average:100.50 Median:89.00 stddev:17.43 (19.6%) stddev-sans-first:18.15 04:28:48 INFO - PROCESS | 1974 | Values: 91.0 122.0 89.0 87.0 98.0 118.0 91.0 89.0 134.0 86.0 04:28:48 INFO - PROCESS | 1974 | 04:28:48 INFO - PROCESS | 1974 | [#6] imaging-darkroom Cycles:10 Average:113.40 Median:95.00 stddev:22.50 (23.7%) stddev-sans-first:22.85 04:28:48 INFO - PROCESS | 1974 | Values: 95.0 113.0 152.0 96.0 97.0 116.0 151.0 123.0 96.0 95.0 04:28:48 INFO - PROCESS | 1974 | 04:28:48 INFO - PROCESS | 1974 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:97.00 stddev:4.43 (4.6%) stddev-sans-first:4.70 04:28:48 INFO - PROCESS | 1974 | Values: 97.0 108.0 97.0 96.0 98.0 96.0 95.0 97.0 97.0 90.0 04:28:48 INFO - PROCESS | 1974 | 04:28:48 INFO - PROCESS | 1974 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:59.00 stddev:1.43 (2.4%) stddev-sans-first:1.22 04:28:48 INFO - PROCESS | 1974 | Values: 56.0 60.0 57.0 59.0 60.0 58.0 59.0 58.0 60.0 57.0 04:28:48 INFO - PROCESS | 1974 | 04:28:48 INFO - PROCESS | 1974 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.50 stddev:5.66 (8.1%) stddev-sans-first:5.29 04:28:48 INFO - PROCESS | 1974 | Values: 61.0 65.0 64.0 73.0 70.0 81.0 71.0 67.0 69.0 65.0 04:28:48 INFO - PROCESS | 1974 | 04:28:48 INFO - PROCESS | 1974 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:84.00 stddev:1.75 (2.1%) stddev-sans-first:1.83 04:28:48 INFO - PROCESS | 1974 | Values: 84.0 81.0 85.0 81.0 84.0 84.0 83.0 81.0 83.0 86.0 04:28:48 INFO - PROCESS | 1974 | 04:28:48 INFO - PROCESS | 1974 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:125.00 stddev:6.74 (5.4%) stddev-sans-first:7.07 04:28:48 INFO - PROCESS | 1974 | Values: 127.0 123.0 130.0 119.0 119.0 118.0 116.0 123.0 128.0 138.0 04:28:48 INFO - PROCESS | 1974 | 04:28:48 INFO - PROCESS | 1974 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.30 Median:137.00 stddev:1.77 (1.3%) stddev-sans-first:1.41 04:28:48 INFO - PROCESS | 1974 | Values: 133.0 138.0 137.0 137.0 137.0 136.0 134.0 136.0 136.0 139.0 04:28:48 INFO - PROCESS | 1974 | 04:28:48 INFO - PROCESS | 1974 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:1.42 (2.1%) stddev-sans-first:1.48 04:28:48 INFO - PROCESS | 1974 | Values: 67.0 68.0 66.0 64.0 66.0 66.0 65.0 68.0 65.0 68.0 04:28:48 INFO - PROCESS | 1974 | -------- Summary: end -------- 04:28:48 INFO - PROCESS | 1974 | 04:28:49 INFO - TEST-INFO | 1974: exit 0 04:28:49 INFO - TEST-OK | kraken | took 57037ms 04:28:49 INFO - SUITE-END | took 1167s 04:28:50 INFO - Completed test suite (00:19:28) 04:28:50 INFO - javascript benchmark 04:28:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3447.2588393495403, 3690.9815450922724, 3694.501242332288, 3739.1399978005056, 3749.5500539935197, 6036.275646922375, 6054.243219597551, 6062.757489700418, 6067.211262535875, 6085.8174254772375, 6063.514918806496, 6064.595926347084, 6124.727153123165, 6127.724252408641, 6133.969330153343, 5404.135338345865, 5407.297051383314, 5421.457854214586, 5479.726013699299, 5518.696471694056, 5331.360236771593, 5430.864228394302, 5449.809256676017, 5454.61817672763, 5460.590455715817, 5386.703731294777, 5401.837944861641, 5430.402655707869, 5437.673739575618, 5452.781888724447, 5452.372977107644, 5476.7535460904355, 5498.972505137469, 5503.724813759296, 5542.528885044776, 5358.33020872391, 5441.455854414567, 5448.754806033738, 5481.643693159932, 5528.75120619569, 5790.218320526717, 5800.593958422912, 5846.970765146147, 5860.531157507389, 6098.57309988301, 6324.33594472583, 6363.109164716943, 6370.394812492806, 6382.393672601142, 6389.7763578275, 5658.924804287172, 6434.581752186093, 6446.935530644727, 6448.45188159007, 6451.29035806061, 5719.48524632785, 6073.605215660968, 6137.693115344215, 6180.443760061616, 6227.408396202353, 5495.642783219078, 5720.513756330759, 6552.115464412339, 6552.50856185788, 6567.9671601641685, 6122.234720659918, 6328.462080723098, 6331.2085989251345, 6351.936480635227, 6352.745890164341, 6306.3378345274, 6417.903731444032, 6478.935210647927, 6524.934750652527, 6535.346465353522, 6349.0, 6366.745330186834, 6408.231012278557, 6416.422521973045, 6426.132472116298, 6223.782167624111, 6360.0777887206095, 6414.839629009219, 6420.678966051679, 6443.130177426081, 5103.668261562986, 5170.534651881274, 5175.689458632494, 5179.0, 5219.086659834514, 4627.074585082997, 4640.79116439761, 4645.187092258841, 4676.3453116563705, 4696.60078893291, 6120.510359171256, 6131.284916201153, 6142.815715528542, 6170.598911070766, 6198.659073750897, 6283.8114856554375, 6376.075469056961, 6420.390062944013, 6481.351864813575, 6501.544891857525, 6196.659183744847, 6202.689865506707, 6211.751529938842, 6215.192025036717, 6231.065340199007, 5532.446755324516, 5587.469190426903, 5710.486056254957, 5737.3688894221605, 5745.741441635137, 6651.368120028589, 6676.365745254193, 6691.7323307068145, 6711.362420570135, 6723.966380168068, 6391.32891046452, 6393.392627700361, 6394.71223794921, 6411.583247089111, 6425.10048593188, 6473.967630161819, 6531.738730450728, 6610.140681711539, 6630.635315057718, 6714.160729908762, 6327.620342779448, 6340.587861788969, 6344.016677415008, 6345.0, 6345.111684364285, 6383.170187875732, 6391.392817682313, 6422.357764223727, 6431.678416079271, 6440.355964403522, 5505.394406615349, 6201.720922558586, 6264.59280146789, 6266.27937787142, 6296.181496405438, 6278.121063051268, 6293.96853015732, 6299.590526615755, 6300.180976473029, 6304.621722696653, 6058.57589968698, 6257.061440783918, 6311.715972781328, 6331.2085989251345, 6346.01636746305, 6199.876002480015, 6214.067889816563, 6266.248050234001, 6270.686465676789, 6331.3352098029045, 6290.370962903856, 6293.622382657055, 6294.905576416449, 6302.3067462578165, 6314.179156709598], "unit": "score", "name": "dojo.html", "value": 5941.644373535094}, {"lowerIsBetter": false, "replicates": [503.0542579949694, 531.4393315052621, 593.821264789393, 651.5862427358629, 678.5148618737602, 36861.0, 38919.80540097299, 39704.20591588166, 39735.2052958941, 39736.801315993376, 41248.79375603118, 41759.791201043954, 41784.95537611553, 41871.79064104683, 41874.58125418745, 8599.269062129726, 9306.62773489063, 11897.821532676973, 12057.397130143501, 12073.818892716616, 11904.940475297612, 11992.940035299811, 12113.091518136174, 12138.15032947694, 12207.084468664842, 11998.460069296903, 12027.45876435558, 12149.088818338616, 12346.444410001526, 12349.629511114681, 10314.329568578056, 10869.402182879938, 11723.76552468946, 12035.578754743541, 12153.392330383489, 10373.377597344184, 11955.462004209832, 11983.46074426653, 12262.632121036384, 12350.691232719164, 42241.788791056155, 42260.36609450861, 42449.36325955113, 42586.57413425857, 42600.0, 3355.060583036729, 3380.2732412531177, 3447.293304872495, 3537.7877327360184, 3766.0, 28254.0, 28996.565051524245, 29091.56362654562, 29160.854195729098, 30866.537001944987, 2362.822788290885, 2791.232411086947, 2850.957235641467, 2853.5862299966598, 2892.3781387001686, 495089.0, 495887.0, 496634.0, 498290.50854745856, 502496.0, 67964.6601766988, 68481.63036739237, 69053.65473172603, 69266.0, 69443.0, 72188.0, 72561.2743872565, 72666.90999635009, 72667.63666181636, 73069.6346518264, 15805.683886322438, 17245.913770431318, 18520.0, 19113.0, 19344.032798360306, 14008.579742607739, 14275.214863182624, 14311.284435778169, 14366.712665746627, 14370.425182992773, 17055.31778728862, 20157.891315977467, 20262.290819821235, 20408.18367265293, 20453.897730511253, 8735.737927862174, 8885.955570222108, 8888.288936885034, 8898.688545900992, 8923.241524470362, 991.4546999150439, 1031.339942436841, 1100.312304809494, 1163.9301641901513, 1190.3155685480883, 30143.397132057235, 30207.244818879703, 30359.696403036127, 30846.228844279074, 30953.45232738354, 1180.2977228549, 1182.9526818927318, 1216.7627312674122, 1223.1132428988913, 1246.6571692784376, 13870.237136957363, 15621.843781562266, 15754.527364179094, 15788.0, 15872.92063539675, 515842.0, 519207.0, 521779.3911030496, 526141.0, 530622.0, 61283.08075378873, 62529.68735156386, 62638.373616263256, 62649.68675156595, 62738.686306568175, 1541.961450963735, 1563.8357972412732, 1578.2503310927218, 1583.4141367694026, 1592.4267263785027, 29672.851635741685, 30937.0, 30969.8451507741, 31139.377212455172, 31782.52326215155, 56988.43011569831, 57394.0, 57894.710526447096, 57999.42000580109, 58074.41925580859, 407062.0, 411555.0, 413766.0, 413782.0, 414756.0, 33784.49323260202, 34649.0, 34695.82652086723, 35046.47430288599, 35076.947691569294, 43629.56370436255, 43743.56256437522, 44160.77919610382, 44223.77888110668, 44313.77843110764, 35009.64990350064, 36383.0, 36485.817570911975, 36749.63250367462, 36930.44604330991, 29964.400711985203, 35718.64281357153, 35739.46390804192, 36018.8199059003, 36235.818820905726, 29471.85264073666, 34697.306053879285, 36947.0, 37198.070048249014, 37240.44139337966, 33177.668223318426, 33810.15474613154, 33891.0, 33919.321613567095, 34149.48775768316, 25120.0, 25474.14094758253, 25510.36224094338, 26027.73972260253, 26071.60892586575], "unit": "score", "name": "ext.html", "value": 20966.862691565504}, {"lowerIsBetter": false, "replicates": [341.3207716643876, 368.1532475306794, 376.27003612990796, 379.6469283566284, 380.41796052040377, 20725.68911466329, 20910.581788364223, 21396.25113121041, 21817.563648727017, 21829.126834926603, 20545.075471603777, 21278.787212127874, 22808.201712940052, 23089.538209235805, 23135.30594082176, 5315.787368505275, 5342.198670199472, 5499.780008799643, 5512.503874651281, 5528.44715528446, 5405.864853378657, 5408.134698448249, 5489.533389661883, 5510.311211098613, 5512.503874651281, 5390.838274851761, 5397.4062853086125, 5486.780528778844, 5507.870886468264, 5523.972380138093, 5542.0, 5965.970170149165, 5983.700814959257, 6126.540509461808, 6132.294786099611, 5288.312519372495, 5356.7857285708915, 5372.54333381663, 5377.489138531833, 5392.892142157135, 13069.01982351318, 13588.93205533966, 13627.705367990025, 13627.931860340734, 13664.453421863114, 2170.511634882155, 2319.7216334039854, 2323.581755284048, 2467.753224677536, 2547.5669136246884, 9752.317337786359, 9910.306278560503, 9938.751531211705, 10315.742106447324, 10456.63401780934, 1762.7091529897552, 1763.444514977778, 1768.8938663680092, 1837.5681714797013, 1851.9536461898983, 98038.50980745051, 103629.0, 106190.46904765426, 107387.46306268418, 107417.92582074157, 10789.56841726338, 11300.248461488482, 11994.760104797855, 12002.979746721627, 12163.148579599343, 14727.337269822669, 14798.0, 14864.256787160599, 14884.0, 14909.925450372679, 7774.611269436506, 9196.816063678823, 9338.252939764803, 9359.625614975324, 9376.0, 9422.481763503074, 9546.904530954602, 9559.808803823884, 9586.808263834824, 9641.42151470914, 3759.793211373401, 3833.4824798652385, 4647.721136731807, 4679.555442232982, 4752.144613969519, 1934.4100049484762, 1981.643304205228, 1994.1923520974028, 2032.5833204193104, 2038.979610203879, 962.7015625156224, 1006.285537268533, 1024.4263212600968, 1058.772363941756, 1141.5833220874322, 17175.398861039805, 21670.674939875913, 21675.566488670138, 21778.564428711335, 21795.59570863916, 854.2183901729971, 922.0318665401302, 988.5452691761726, 1028.3161697471248, 1109.3011402816173, 6054.212952316171, 6476.384743449365, 9200.6779762708, 11461.255018423775, 11558.595449159238, 404150.0, 518390.0, 591616.0, 641918.0, 662237.0, 105371.47314263532, 107336.46331768291, 114012.0, 116318.0, 121559.78440215661, 477.7826089129438, 488.10920070870094, 489.1732971278528, 489.2367906066548, 492.5419359995239, 11400.144989125683, 11404.600838970597, 11500.654980350602, 11843.881561184622, 11955.820662690241, 36648.63351366452, 50599.49400505948, 52602.73698631483, 54476.45523544714, 57458.0, 73370.89943650956, 73953.0, 75761.10597234893, 76999.61500192463, 78712.21287787278, 8267.669293228204, 8284.627191776264, 8511.616977236163, 8567.228949394585, 8584.184502472255, 9713.271504637321, 13507.324633768076, 13817.032807703365, 13986.608035178811, 14039.719205616035, 11893.226940249202, 12122.27266364021, 12163.966062884754, 12218.389080546114, 12218.572349967708, 9570.47362395075, 10631.468426578485, 11914.702132446759, 11952.402379881145, 12045.879541204476, 11745.354005529778, 12007.75984480288, 12092.274463532216, 12213.572524961939, 12574.685632859251, 7130.607816570138, 8347.666093356198, 8618.893089999841, 8665.2634526066, 8673.176048275403, 9207.40151890125, 10317.48412579353, 12156.027517798731, 12242.0, 12374.010079193464], "unit": "score", "name": "jquery.html", "value": 9082.543088326107}, {"lowerIsBetter": false, "replicates": [1668.949931502055, 1681.285453682185, 1753.4301352060575, 2102.8317734581233, 2132.477543001965, 8351.95824020879, 9058.592363343649, 9147.862782058266, 9281.257499400048, 9348.439093654386, 7619.619019049053, 9087.136722011399, 9165.816683666322, 9181.724548263563, 9190.678326258583, 2509.1970569417795, 2536.2898388451263, 2550.642909992593, 2550.8086893483064, 2556.7698907098356, 2532.1896992962165, 2602.258356368435, 2607.3220962549685, 2614.372550587864, 2634.894604215829, 2567.0, 2585.121058839994, 2598.5062838060803, 2616.463624956889, 2623.435961268327, 2208.7349518057777, 2330.4406942333717, 2541.4535874786825, 2573.395252115751, 2606.569915963864, 2572.5626643470655, 2580.1743442098536, 2591.922242332733, 2595.3641357867446, 2608.6869575650853, 9317.301202409779, 9340.065993400674, 9342.346035777498, 9346.859797103049, 9360.204382627484, 5731.455511726421, 5762.394948530386, 5774.913376299359, 5812.854678633025, 5885.0, 3625.9818700906326, 3735.477033215352, 3737.121776382548, 3794.1083845296334, 3794.8861534153743, 1066.5520481397832, 1088.314361951973, 1091.7161538000098, 1099.6646022962993, 1122.2480937771713, 12566.120371573994, 12638.368081595883, 12662.050346223978, 12662.620121396372, 12664.36678166088, 4991.425986011583, 5059.392872855207, 5107.157319042316, 5132.153194722829, 5150.201718733602, 10658.253922225369, 10688.51901664427, 10689.572417103229, 10701.357918524913, 10702.143828493858, 5672.120821272627, 5749.453801888814, 5805.854853628609, 5828.475437210586, 5829.970850145722, 4733.934864655425, 5063.0, 5183.2743415921805, 5184.585233181337, 5251.133562962068, 4074.5942649785775, 4160.292750232407, 4168.583141685807, 4189.539150693421, 4195.748255104703, 1354.2754626274896, 1370.6093763277418, 1373.7676276051416, 1378.7035787305576, 1381.5855243426931, 1410.5697762182633, 1428.5928510374702, 1438.0365155345944, 1461.5103940179947, 1491.172399318367, 8542.615582298688, 8573.871391929126, 8598.699045533376, 8631.395802293904, 8658.307335413152, 533.2454576773822, 543.3915609795051, 548.3392512023003, 548.9780408783604, 554.9833504994857, 6265.655388953652, 6326.557141000178, 6362.586431881913, 6410.935890641033, 6473.2232132144445, 11048.447577621087, 11119.888801112047, 11260.0, 11420.14348923834, 11437.599684011186, 10842.295250808673, 10955.83566246507, 11110.166737494721, 11174.38540880243, 11361.488733007034, 8677.56612169389, 8733.475991440408, 8788.692395766118, 8791.868121978176, 8882.467051976902, 8060.0, 8141.470804397695, 8190.0, 8222.97212848394, 8291.295239904435, 9554.140127388568, 9799.902000979899, 10011.399316041061, 10057.647982320585, 10271.794564108526, 9884.505774711379, 10013.39919604826, 10018.248631352824, 10033.548490318099, 10242.590296388062, 7574.5076570022775, 7760.495567788075, 7766.728164514215, 7815.25755053269, 7823.726169584037, 8501.914980850112, 8679.349048821237, 8722.433041852259, 8724.476531408136, 8734.257588105082, 7550.509216900884, 7665.0, 7703.268189521987, 7745.302922736981, 7829.882551761614, 7400.629968501661, 7496.475246732676, 7504.437167212372, 7637.198094200029, 7638.885416718643, 7973.561454120079, 7993.320567751573, 8061.0326760789085, 8099.83800324002, 8174.223448772357, 7231.204567497676, 7353.338199562065, 7363.226861179499, 7374.299441553044, 7374.741884034033, 7457.47797654159, 7489.850202996018, 7526.736564220226, 7539.886901696369, 7542.622868856645], "unit": "score", "name": "mootools.html", "value": 5090.832501222799}, {"lowerIsBetter": false, "replicates": [295.7102040000799, 335.08521735661645, 338.4922616075886, 339.90142858571, 344.2924789557458, 7018.298170182979, 7060.0, 7079.8584028319465, 7102.218755936856, 7122.074130363052, 7060.1880783709885, 7080.5397649152765, 7088.184858741233, 7095.751648692297, 7118.822029449267, 4944.554990050895, 5015.5486006259425, 5090.236464530313, 5098.0, 5209.583233341324, 5071.087204303224, 5092.185250359943, 5107.7956881724685, 5109.923351149736, 5117.590592752589, 5006.27409025691, 5018.473060328668, 5019.498050194969, 5036.017976494585, 5042.495750424965, 5042.647014708972, 5053.722045287508, 5065.924011139836, 5070.059365567961, 5087.872803179932, 4406.317020861771, 4410.492793328776, 4415.690901636886, 4416.895776055986, 4430.756308403036, 6583.308752580958, 6743.966280168568, 6805.319468053204, 6842.692078856463, 6843.8973415398805, 6044.214252147237, 6084.908726369108, 6088.4215999479975, 6105.236845394325, 6122.724477398528, 7537.246275372474, 7555.0, 7556.206598307153, 7563.357114645261, 7568.394528437711, 4612.677112602119, 4974.925376119361, 4990.950090499085, 4994.675346102528, 4995.5753760930365, 6394.808155755335, 7220.4584656151, 7969.481983671043, 7989.520628762293, 8003.559804210766, 4972.453030166679, 5026.1204289249235, 5027.748612569357, 5051.4695956924725, 5093.312402825645, 4169.770662613525, 5138.972205558904, 5235.136202526616, 5277.868053298698, 5316.521513063843, 6111.297200821962, 6119.326874043852, 6122.387761223842, 6130.570860039755, 6143.508519318444, 6260.937390626126, 7600.391968642495, 7648.9617551913, 7655.770326890202, 7664.195259497673, 1673.2470388325303, 1733.800612929504, 1782.189103957696, 1811.5742800441885, 1813.238439855264, 1083.2525557365393, 1084.951177197028, 1103.6755892928518, 1111.9110471162287, 1113.0, 5155.355580552431, 5794.391588883191, 6838.418734407532, 7261.636918154071, 7283.890741638879, 7836.216378362118, 7849.843003139905, 7852.882206766903, 7872.72445464406, 7931.484453510619, 7255.673494692752, 7261.2012678605315, 7277.017602623684, 7278.0, 7291.30732580404, 3721.423179407196, 3783.886483405502, 4051.7366371186367, 4059.289624315792, 4154.210699966997, 8089.635966381409, 8253.463524870864, 8266.545340006358, 8332.916670833336, 8383.203595658402, 7435.85128297431, 8219.671213151407, 8236.341092712568, 8252.298554622805, 8256.669733210605, 6781.423578995742, 8307.08622051574, 8357.373197010249, 8364.958175209085, 8373.037100733372, 7748.418868584766, 8006.879896801669, 8010.239027292398, 8017.0, 8021.358291336795, 7083.150021997393, 7740.0, 7774.067111946602, 7831.960840195762, 7843.8039049021945, 8305.294050005576, 8330.375221858507, 8338.99932008163, 8342.0, 8356.075373619185, 4126.834926602903, 4913.459519452929, 4927.975360123177, 4961.479044700399, 4975.875603109951, 7726.806829829299, 7858.882116768367, 7873.291403773688, 7889.13219545838, 7967.322777563972, 6201.534884883562, 7651.196624354585, 7676.193999629959, 7679.308862202429, 7682.347000505019, 6923.723051077901, 7648.579328137006, 7651.1201211859125, 7654.73208437702, 7656.234376562299, 7163.820904477429, 7466.887996679946, 7512.32389084985, 7517.962410187914, 7522.774316770506, 7643.0, 7649.0, 7656.387489000978, 7701.768946931601, 7716.92283077162, 7484.925150748641, 7500.549967001997, 7504.774856754306, 7526.172121066569, 7531.133919599316], "unit": "score", "name": "prototype.html", "value": 5495.856577510207}, {"lowerIsBetter": false, "replicates": [727.5162017258525, 766.3409467857645, 773.9458237923344, 779.7738655789822, 794.8728203487443, 15571.22143892805, 15817.60455988601, 15853.445129420457, 15854.04875707457, 15878.444254451097, 14672.26638668065, 14689.706205875877, 14763.188024658639, 14770.852291477082, 14796.482123125692, 808.2200676347353, 974.6491263145244, 974.8342781727088, 1007.7077647482222, 1008.5915204342253, 974.1135566634364, 988.406955826502, 990.4750482244386, 990.8563258327538, 992.1120597065658, 1029.9124574411185, 1041.2398948767404, 1054.051353781595, 1055.430067763407, 1055.975703567542, 1045.0333441566559, 1045.8222102242637, 1047.738065483629, 1048.958041678332, 1050.112654806687, 764.3121190928154, 783.1463704562054, 784.6508303804809, 793.111714879333, 796.2992566541465, 15012.924935375362, 15115.31981060855, 15165.545033649008, 15175.0, 15234.695306093927, 11116.444177791078, 13344.866551334557, 13381.53164639233, 13533.458661653522, 13558.98307626932, 10180.990980251914, 10373.948130259301, 10397.960203979617, 10442.425666588335, 10651.307665001828, 3215.324781795826, 3556.733245006609, 3619.674229319374, 3660.9932268626076, 3708.870189543353, 64179.0, 81992.0, 87451.56274218652, 88691.66962495503, 90482.0, 8220.917790822015, 9735.269854760922, 9912.256580756472, 9964.10323070927, 10003.799924001625, 18413.355532556296, 20589.48526286825, 20757.481062973246, 22753.08987640509, 23092.4226894329, 7520.6239688015385, 7686.423518236154, 7689.346405555479, 7709.922900770921, 7760.417968652374, 4104.507459104927, 4128.422020917014, 4169.728967617156, 4235.152969406131, 4283.100548884707, 3221.4684577044995, 3721.0883333583447, 3779.338615742289, 3781.3382658034734, 3784.4701741756176, 648.5913874259187, 662.4733336997002, 664.3522565498697, 675.878341898463, 690.5683947532792, 603.1435361786274, 616.4913945994573, 621.3755176048043, 623.4825095170997, 628.5788521690479, 8017.959910200411, 8603.612837422332, 8630.136986301446, 8642.956785216034, 8938.68714594986, 562.1230879827482, 566.7194738604417, 615.4430240632234, 627.3632263252802, 635.1425575473166, 3932.410138479251, 3953.4267531207815, 4015.678745700337, 4065.7560546367313, 4079.326911059642, 89242.55378723064, 89586.0, 89683.0, 91049.54475227582, 91401.54299228461, 63847.29831265789, 78930.21069789343, 82661.58669206615, 83140.58429707812, 83381.58309208415, 76246.23753762503, 76835.61582192164, 77017.61491192508, 77193.22806771973, 77555.61222193853, 6707.987603718767, 7973.242541958504, 8139.552324622203, 8171.713990010321, 8207.974003249594, 51246.48753512566, 51798.0, 51934.961300773015, 52013.47986520086, 52050.73974630103, 63914.680426597566, 68750.0, 72845.0, 72925.90611140944, 73438.0, 10668.786624267315, 10727.0, 11358.94320528392, 11552.422378880854, 11768.35274059935, 10243.59025638996, 12219.572314968933, 12325.69185770327, 12570.937145314581, 12880.742385152433, 11689.766204676029, 11786.705332366417, 11787.292762434281, 11792.351420671945, 12368.072394570263, 10273.229507786797, 10352.430616316175, 10367.896321036693, 10701.250912436366, 10734.785304294026, 10711.571537138427, 11348.262362946381, 12003.39983000829, 12056.397180140782, 12088.0, 9883.357581757164, 9970.800583988424, 10066.748331291776, 10521.789564208826, 10533.42066186367, 10025.097741203326, 10033.14718248957, 10033.794897867772, 10053.547590358305, 10202.693919182437], "unit": "score", "name": "yui.html", "value": 7146.00812638613}], "name": "dromaeo_css", "value": 7805.990713088344}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [118.0, 111.0, 116.0, 115.0, 115.0, 131.0, 116.0, 116.0, 117.0, 114.0], "unit": "score", "name": "ai-astar", "value": 116.9}, {"lowerIsBetter": true, "replicates": [153.0, 117.0, 145.0, 151.0, 118.0, 173.0, 150.0, 148.0, 170.0, 155.0], "unit": "score", "name": "audio-beat-detection", "value": 148.0}, {"lowerIsBetter": true, "replicates": [190.0, 199.0, 192.0, 200.0, 202.0, 194.0, 200.0, 195.0, 201.0, 193.0], "unit": "score", "name": "audio-dft", "value": 196.6}, {"lowerIsBetter": true, "replicates": [71.0, 80.0, 62.0, 115.0, 81.0, 83.0, 87.0, 64.0, 119.0, 58.0], "unit": "score", "name": "audio-fft", "value": 82.0}, {"lowerIsBetter": true, "replicates": [86.0, 78.0, 121.0, 78.0, 66.0, 102.0, 161.0, 116.0, 118.0, 121.0], "unit": "score", "name": "audio-oscillator", "value": 104.7}, {"lowerIsBetter": true, "replicates": [91.0, 122.0, 89.0, 87.0, 98.0, 118.0, 91.0, 89.0, 134.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 100.5}, {"lowerIsBetter": true, "replicates": [95.0, 113.0, 152.0, 96.0, 97.0, 116.0, 151.0, 123.0, 96.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 113.4}, {"lowerIsBetter": true, "replicates": [97.0, 108.0, 97.0, 96.0, 98.0, 96.0, 95.0, 97.0, 97.0, 90.0], "unit": "score", "name": "imaging-desaturate", "value": 97.1}, {"lowerIsBetter": true, "replicates": [56.0, 60.0, 57.0, 59.0, 60.0, 58.0, 59.0, 58.0, 60.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.4}, {"lowerIsBetter": true, "replicates": [61.0, 65.0, 64.0, 73.0, 70.0, 81.0, 71.0, 67.0, 69.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [84.0, 81.0, 85.0, 81.0, 84.0, 84.0, 83.0, 81.0, 83.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.2}, {"lowerIsBetter": true, "replicates": [127.0, 123.0, 130.0, 119.0, 119.0, 118.0, 116.0, 123.0, 128.0, 138.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.1}, {"lowerIsBetter": true, "replicates": [133.0, 138.0, 137.0, 137.0, 137.0, 136.0, 134.0, 136.0, 136.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.3}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 66.0, 64.0, 66.0, 66.0, 65.0, 68.0, 65.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.3}], "name": "kraken", "value": 1496.1}]} 04:28:50 INFO - Return code: 0 04:28:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:28:50 ERROR - # TBPL SUCCESS # 04:28:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:28:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:28:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:28:50 INFO - 2016-05-11 04:28:50.209 screenresolution[1979:13651] starting screenresolution argv=screenresolution get 04:28:50 INFO - 2016-05-11 04:28:50.212 screenresolution[1979:13651] Display 0: 1600x1200x32@60 04:28:50 INFO - 2016-05-11 04:28:50.218 screenresolution[1980:13654] starting screenresolution argv=screenresolution list 04:28:50 INFO - Available Modes on Display 0 04:28:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:28:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:28:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:28:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:28:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:28:50 INFO - Intel Iris: 04:28:50 INFO - Chipset Model: Intel Iris 04:28:50 INFO - Type: GPU 04:28:50 INFO - Bus: Built-In 04:28:50 INFO - VRAM (Dynamic, Max): 1536 MB 04:28:50 INFO - Vendor: Intel (0x8086) 04:28:50 INFO - Device ID: 0x0a2e 04:28:50 INFO - Revision ID: 0x0009 04:28:50 INFO - Displays: 04:28:50 INFO - Display: 04:28:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:28:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:28:50 INFO - Display Serial Number: 1600x1200 60 04:28:50 INFO - Main Display: Yes 04:28:50 INFO - Mirror: Off 04:28:50 INFO - Online: Yes 04:28:50 INFO - Rotation: Supported 04:28:50 INFO - Return code: 0 04:28:50 INFO - Running post-action listener: _resource_record_post_action 04:28:50 INFO - Running post-run listener: _resource_record_post_run 04:28:51 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 253952; Write bytes: 509518848; Read time: 7; Write time: 1761 04:28:51 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 196073984; Write bytes: 196042752; Read time: 18002; Write time: 484 04:28:51 INFO - run-tests - Wall time: 1170s; CPU: 53.0%; Read bytes: 253952; Write bytes: 303363072; Read time: 7; Write time: 1247 04:28:51 INFO - Running post-run listener: _upload_blobber_files 04:28:51 INFO - Blob upload gear active. 04:28:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:28:51 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 04:28:51 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'] 04:28:51 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 04:28:51 INFO - (blobuploader) - INFO - Open directory for files ... 04:28:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:28:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:28:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:28:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:28:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:28:52 INFO - (blobuploader) - INFO - Done attempting. 04:28:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:28:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:28:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:28:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:28:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:28:53 INFO - (blobuploader) - INFO - Done attempting. 04:28:53 INFO - (blobuploader) - INFO - Iteration through files over. 04:28:53 INFO - Return code: 0 04:28:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:28:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:28:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fc4ae00cb3722156b4f27667cc300957cee2415976d390a93700c2c4e1f7b1f075361e4d0bc50ec76d1402b6ec2828d7014dc51bf1fd4bb1eec44ca72c95f09a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/16b4ffde4761c74d5352dd71ce98dee333e6713a5b00d4a412756a2ac8d9ca5a20108c569b1858d300ddf616cd8b91f6e4f3f4642fbf2673ac5025039b44ec92"} 04:28:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:28:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:28:53 INFO - Contents: 04:28:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fc4ae00cb3722156b4f27667cc300957cee2415976d390a93700c2c4e1f7b1f075361e4d0bc50ec76d1402b6ec2828d7014dc51bf1fd4bb1eec44ca72c95f09a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/16b4ffde4761c74d5352dd71ce98dee333e6713a5b00d4a412756a2ac8d9ca5a20108c569b1858d300ddf616cd8b91f6e4f3f4642fbf2673ac5025039b44ec92"} 04:28:53 INFO - Running post-run listener: copy_logs_to_upload_dir 04:28:53 INFO - Copying logs to upload dir... 04:28:53 INFO - mkdir: /builds/slave/test/build/upload/logs 04:28:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.346542 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-05-11 04:28:53.650709) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 04:28:53.655412) ========= 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.Dg5QJn5r7a/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.Y2E1dIrdav/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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/fc4ae00cb3722156b4f27667cc300957cee2415976d390a93700c2c4e1f7b1f075361e4d0bc50ec76d1402b6ec2828d7014dc51bf1fd4bb1eec44ca72c95f09a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/16b4ffde4761c74d5352dd71ce98dee333e6713a5b00d4a412756a2ac8d9ca5a20108c569b1858d300ddf616cd8b91f6e4f3f4642fbf2673ac5025039b44ec92"} build_url:https://queue.taskcluster.net/v1/task/EZxbnFY2RleldqUphQOzRQ/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010798 build_url: 'https://queue.taskcluster.net/v1/task/EZxbnFY2RleldqUphQOzRQ/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/fc4ae00cb3722156b4f27667cc300957cee2415976d390a93700c2c4e1f7b1f075361e4d0bc50ec76d1402b6ec2828d7014dc51bf1fd4bb1eec44ca72c95f09a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/16b4ffde4761c74d5352dd71ce98dee333e6713a5b00d4a412756a2ac8d9ca5a20108c569b1858d300ddf616cd8b91f6e4f3f4642fbf2673ac5025039b44ec92"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 04:28:53.683366) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:28:53.684006) ========= 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.Dg5QJn5r7a/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.Y2E1dIrdav/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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.005022 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:28:53.733968) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 04:28:53.734282) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 04:28:53.734575) ========= ========= Total master_lag: 0.16 =========