builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0231 starttime: 1464237968.48 results: success (0) buildid: 20160525194948 builduid: 4cbf067958764ac196bcd4a921191ebd revision: 7c3ef5d06736bc63d138975a7194050569c62636 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 21:46:08.481534) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 21:46:08.481892) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 21:46:08.482186) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 21:46:08.512541) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 21:46:08.512826) ========= 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.nNCK4JoVpY/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.jBz3CFuQaD/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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-25 21:46:08-- 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% 18.8M=0.001s 2016-05-25 21:46:09 (18.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.541431 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 21:46:09.075129) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 21:46:09.075517) ========= 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.nNCK4JoVpY/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.jBz3CFuQaD/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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.026779 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 21:46:09.124027) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-25 21:46:09.124397) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 7c3ef5d06736bc63d138975a7194050569c62636 --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 7c3ef5d06736bc63d138975a7194050569c62636 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nNCK4JoVpY/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.jBz3CFuQaD/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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-25 21:46:09,198 truncating revision to first 12 chars 2016-05-25 21:46:09,198 Setting DEBUG logging. 2016-05-25 21:46:09,198 attempt 1/10 2016-05-25 21:46:09,198 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/7c3ef5d06736?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 21:46:10,151 unpacking tar archive at: mozilla-beta-7c3ef5d06736/testing/mozharness/ program finished with exit code 0 elapsedTime=1.261195 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-25 21:46:10.405307) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 21:46:10.405703) ========= script_repo_revision: 7c3ef5d06736bc63d138975a7194050569c62636 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 21:46:10.406158) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 21:46:10.406497) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 21:46:10.427272) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2016-05-25 21:46:10.427627) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nNCK4JoVpY/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.jBz3CFuQaD/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 21:46:10 INFO - MultiFileLogger online at 20160525 21:46:10 in /builds/slave/test 21:46:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 21:46:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:46:10 INFO - {'append_to_log': False, 21:46:10 INFO - 'base_work_dir': '/builds/slave/test', 21:46:10 INFO - 'blob_upload_branch': 'Mozilla-Beta', 21:46:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:46:10 INFO - 'branch': 'Mozilla-Beta', 21:46:10 INFO - 'buildbot_json_path': 'buildprops.json', 21:46:10 INFO - 'config_files': ('talos/mac_config.py',), 21:46:10 INFO - 'default_actions': ('clobber', 21:46:10 INFO - 'read-buildbot-config', 21:46:10 INFO - 'download-and-extract', 21:46:10 INFO - 'populate-webroot', 21:46:10 INFO - 'create-virtualenv', 21:46:10 INFO - 'install', 21:46:10 INFO - 'run-tests'), 21:46:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:46:10 INFO - 'download_minidump_stackwalk': True, 21:46:10 INFO - 'download_symbols': 'ondemand', 21:46:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:46:10 INFO - 'tooltool.py': '/tools/tooltool.py', 21:46:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:46:10 INFO - '/tools/misc-python/virtualenv.py')}, 21:46:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:46:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:46:10 INFO - 'installer_path': 'installer.exe', 21:46:10 INFO - 'log_level': 'info', 21:46:10 INFO - 'log_name': 'talos', 21:46:10 INFO - 'log_to_console': True, 21:46:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:46:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:46:10 INFO - 'opt_config_files': (), 21:46:10 INFO - 'pip_index': False, 21:46:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:46:10 INFO - 'cmd': ('bash', 21:46:10 INFO - '-c', 21:46:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:46:10 INFO - 'enabled': True, 21:46:10 INFO - 'halt_on_failure': False, 21:46:10 INFO - 'name': 'check_screen_resolution'},), 21:46:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:46:10 INFO - 'cmd': ('bash', 21:46:10 INFO - '-c', 21:46:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:46:10 INFO - 'enabled': True, 21:46:10 INFO - 'halt_on_failure': False, 21:46:10 INFO - 'name': 'check_screen_resolution'},), 21:46:10 INFO - 'run_cmd_checks_enabled': True, 21:46:10 INFO - 'sps_profile': False, 21:46:10 INFO - 'sps_profile_interval': 0, 21:46:10 INFO - 'suite': 'dromaeojs', 21:46:10 INFO - 'system_bits': '32', 21:46:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:46:10 INFO - 'title': 't-yosemite-r7-0231', 21:46:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:46:10 INFO - 'use_talos_json': True, 21:46:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:46:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:46:10 INFO - 'work_dir': 'build'} 21:46:10 INFO - ##### 21:46:10 INFO - ##### Running clobber step. 21:46:10 INFO - ##### 21:46:10 INFO - Running pre-action listener: _resource_record_pre_action 21:46:10 INFO - Running main action method: clobber 21:46:10 INFO - rmtree: /builds/slave/test/build 21:46:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:46:12 INFO - Running post-action listener: _resource_record_post_action 21:46:12 INFO - ##### 21:46:12 INFO - ##### Running read-buildbot-config step. 21:46:12 INFO - ##### 21:46:12 INFO - Running pre-action listener: _resource_record_pre_action 21:46:12 INFO - Running main action method: read_buildbot_config 21:46:12 INFO - Using buildbot properties: 21:46:12 INFO - { 21:46:12 INFO - "project": "", 21:46:12 INFO - "product": "firefox", 21:46:12 INFO - "script_repo_revision": "production", 21:46:12 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 21:46:12 INFO - "repository": "", 21:46:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 21:46:12 INFO - "buildid": "20160525194948", 21:46:12 INFO - "pgo_build": "False", 21:46:12 INFO - "basedir": "/builds/slave/test", 21:46:12 INFO - "buildnumber": 181, 21:46:12 INFO - "slavename": "t-yosemite-r7-0231", 21:46:12 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 21:46:12 INFO - "platform": "yosemite_r7", 21:46:12 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 21:46:12 INFO - "branch": "mozilla-beta", 21:46:12 INFO - "repo_path": "releases/mozilla-beta", 21:46:12 INFO - "revision": "7c3ef5d06736bc63d138975a7194050569c62636", 21:46:12 INFO - "stage_platform": "macosx64", 21:46:12 INFO - "builduid": "4cbf067958764ac196bcd4a921191ebd", 21:46:12 INFO - "slavebuilddir": "test" 21:46:12 INFO - } 21:46:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/XsF9mbzDSWG9QyCzWKof2Q/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 21:46:12 INFO - Running post-action listener: _resource_record_post_action 21:46:12 INFO - ##### 21:46:12 INFO - ##### Running download-and-extract step. 21:46:12 INFO - ##### 21:46:12 INFO - Running pre-action listener: _resource_record_pre_action 21:46:12 INFO - Running main action method: download_and_extract 21:46:12 INFO - mkdir: /builds/slave/test/build/tests 21:46:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:12 INFO - https://queue.taskcluster.net/v1/task/XsF9mbzDSWG9QyCzWKof2Q/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 21:46:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsF9mbzDSWG9QyCzWKof2Q/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 21:46:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsF9mbzDSWG9QyCzWKof2Q/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 21:46:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsF9mbzDSWG9QyCzWKof2Q/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 21:46:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsF9mbzDSWG9QyCzWKof2Q/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 21:46:31 INFO - Downloaded 1241 bytes. 21:46:31 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 21:46:31 INFO - Using the following test package requirements: 21:46:31 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 21:46:31 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 21:46:31 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 21:46:31 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 21:46:31 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 21:46:31 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 21:46:31 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 21:46:31 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 21:46:31 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 21:46:31 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 21:46:31 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 21:46:31 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 21:46:31 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 21:46:31 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 21:46:31 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 21:46:31 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 21:46:31 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 21:46:31 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 21:46:31 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 21:46:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:31 INFO - https://queue.taskcluster.net/v1/task/XsF9mbzDSWG9QyCzWKof2Q/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:46:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsF9mbzDSWG9QyCzWKof2Q/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 21:46:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsF9mbzDSWG9QyCzWKof2Q/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 21:46:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsF9mbzDSWG9QyCzWKof2Q/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 21:46:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsF9mbzDSWG9QyCzWKof2Q/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 21:46:34 INFO - Downloaded 17816935 bytes. 21:46:34 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'] 21:46:34 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 21:46:37 INFO - Return code: 0 21:46:37 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 21:46: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')]} 21:46:37 INFO - https://queue.taskcluster.net/v1/task/XsF9mbzDSWG9QyCzWKof2Q/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:46:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsF9mbzDSWG9QyCzWKof2Q/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 21:46:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsF9mbzDSWG9QyCzWKof2Q/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 21:46:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsF9mbzDSWG9QyCzWKof2Q/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 21:46:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsF9mbzDSWG9QyCzWKof2Q/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 21:46:55 INFO - Downloaded 17816935 bytes. 21:46:55 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'] 21:46:55 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 21:46:58 INFO - Return code: 0 21:46:58 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')]} 21:46:58 INFO - https://queue.taskcluster.net/v1/task/XsF9mbzDSWG9QyCzWKof2Q/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 21:46:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsF9mbzDSWG9QyCzWKof2Q/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 21:46:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsF9mbzDSWG9QyCzWKof2Q/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 21:46:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsF9mbzDSWG9QyCzWKof2Q/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 21:46:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsF9mbzDSWG9QyCzWKof2Q/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 21:47:00 INFO - Downloaded 10845194 bytes. 21:47:00 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'] 21:47:00 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 21:47:00 INFO - Return code: 0 21:47:00 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')]} 21:47:00 INFO - https://queue.taskcluster.net/v1/task/XsF9mbzDSWG9QyCzWKof2Q/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 21:47:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsF9mbzDSWG9QyCzWKof2Q/artifacts/public/build/firefox-47.0.en-US.mac.dmg 21:47:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsF9mbzDSWG9QyCzWKof2Q/artifacts/public/build/firefox-47.0.en-US.mac.dmg 21:47:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsF9mbzDSWG9QyCzWKof2Q/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 21:47:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XsF9mbzDSWG9QyCzWKof2Q/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 21:47:05 INFO - Downloaded 88467278 bytes. 21:47:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XsF9mbzDSWG9QyCzWKof2Q/artifacts/public/build/firefox-47.0.en-US.mac.dmg 21:47:05 INFO - mkdir: /builds/slave/test/properties 21:47:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:47:05 INFO - Writing to file /builds/slave/test/properties/build_url 21:47:05 INFO - Contents: 21:47:05 INFO - build_url:https://queue.taskcluster.net/v1/task/XsF9mbzDSWG9QyCzWKof2Q/artifacts/public/build/firefox-47.0.en-US.mac.dmg 21:47:06 INFO - Running post-action listener: _resource_record_post_action 21:47:06 INFO - Running post-action listener: set_extra_try_arguments 21:47:06 INFO - ##### 21:47:06 INFO - ##### Running populate-webroot step. 21:47:06 INFO - ##### 21:47:06 INFO - Running pre-action listener: _resource_record_pre_action 21:47:06 INFO - Running main action method: populate_webroot 21:47:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:47:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:47:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:47:06 INFO - '--tppagecycles', 21:47:06 INFO - '7'], 21:47:06 INFO - 'tests': ['tsvgm']}}, 21:47:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:47:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:47:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:47:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 21:47:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:47:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:47:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:47:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:06 INFO - 'talos_options': ['--e10s'], 21:47:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:47:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:06 INFO - 'tests': ['damp', 'tps']}, 21:47:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:06 INFO - 'talos_options': ['--e10s'], 21:47:06 INFO - 'tests': ['damp', 'tps']}, 21:47:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:47:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:47:06 INFO - 'other': {'tests': ['a11yr', 21:47:06 INFO - 'ts_paint', 21:47:06 INFO - 'tpaint', 21:47:06 INFO - 'sessionrestore', 21:47:06 INFO - 'sessionrestore_no_auto_restore', 21:47:06 INFO - 'tabpaint']}, 21:47:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:47:06 INFO - 'tests': ['a11yr', 21:47:06 INFO - 'ts_paint', 21:47:06 INFO - 'tpaint', 21:47:06 INFO - 'sessionrestore', 21:47:06 INFO - 'sessionrestore_no_auto_restore', 21:47:06 INFO - 'tabpaint']}, 21:47:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:47:06 INFO - 'tests': ['a11yr', 21:47:06 INFO - 'ts_paint', 21:47:06 INFO - 'tpaint', 21:47:06 INFO - 'sessionrestore', 21:47:06 INFO - 'sessionrestore_no_auto_restore', 21:47:06 INFO - 'tabpaint']}, 21:47:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:47:06 INFO - 'tests': ['a11yr', 21:47:06 INFO - 'ts_paint', 21:47:06 INFO - 'tpaint', 21:47:06 INFO - 'sessionrestore', 21:47:06 INFO - 'sessionrestore_no_auto_restore', 21:47:06 INFO - 'tabpaint']}, 21:47:06 INFO - 'other_l64': {'tests': ['a11yr', 21:47:06 INFO - 'ts_paint', 21:47:06 INFO - 'tpaint', 21:47:06 INFO - 'sessionrestore', 21:47:06 INFO - 'sessionrestore_no_auto_restore', 21:47:06 INFO - 'tabpaint']}, 21:47:06 INFO - 'other_nol64': {'tests': ['a11yr', 21:47:06 INFO - 'ts_paint', 21:47:06 INFO - 'tpaint', 21:47:06 INFO - 'sessionrestore', 21:47:06 INFO - 'sessionrestore_no_auto_restore', 21:47:06 INFO - 'tabpaint']}, 21:47:06 INFO - 'svgr': {'tests': ['tsvgx', 21:47:06 INFO - 'tsvgr_opacity', 21:47:06 INFO - 'tart', 21:47:06 INFO - 'tscrollx', 21:47:06 INFO - 'cart']}, 21:47:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:47:06 INFO - 'tests': ['tsvgx', 21:47:06 INFO - 'tsvgr_opacity', 21:47:06 INFO - 'tart', 21:47:06 INFO - 'tscrollx', 21:47:06 INFO - 'cart']}, 21:47:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:06 INFO - 'tests': ['tp5o']}, 21:47:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:06 INFO - 'talos_options': ['--e10s'], 21:47:06 INFO - 'tests': ['tp5o']}, 21:47:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:06 INFO - 'talos_options': ['--xperf_path', 21:47:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:47:06 INFO - 'tests': ['tp5n']}, 21:47:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:06 INFO - 'talos_options': ['--e10s', 21:47:06 INFO - '--xperf_path', 21:47:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:47:06 INFO - 'tests': ['tp5n']}}, 21:47:06 INFO - 'talos.zip': {'path': '', 21:47:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:47:06 INFO - Running post-action listener: _resource_record_post_action 21:47:06 INFO - ##### 21:47:06 INFO - ##### Running create-virtualenv step. 21:47:06 INFO - ##### 21:47:06 INFO - Running pre-action listener: _resource_record_pre_action 21:47:06 INFO - Running main action method: create_virtualenv 21:47:06 INFO - Creating virtualenv /builds/slave/test/build/venv 21:47:06 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 21:47:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:47:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:47:06 INFO - Using real prefix '/tools/python27' 21:47:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:47:07 INFO - Installing distribute.............................................................................................................................................................................................done. 21:47:10 INFO - Installing pip.................done. 21:47:10 INFO - Return code: 0 21:47:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:47:10 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')]} 21:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:10 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')]} 21:47:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:10 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 0x109500a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095074c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f9d792f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a4d30>, '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 0x109208db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10939bb20>, '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.nNCK4JoVpY/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.jBz3CFuQaD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 21:47:10 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 21:47:10 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 21:47:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNCK4JoVpY/Render', 21:47:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:10 INFO - 'HOME': '/Users/cltbld', 21:47:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:10 INFO - 'LOGNAME': 'cltbld', 21:47:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:10 INFO - 'MOZ_NO_REMOTE': '1', 21:47:10 INFO - 'NO_EM_RESTART': '1', 21:47:10 INFO - 'PAGER': '/bin/cat', 21:47:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:10 INFO - 'PWD': '/builds/slave/test', 21:47:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:10 INFO - 'SHELL': '/bin/bash', 21:47:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jBz3CFuQaD/Listeners', 21:47:10 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 21:47:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:10 INFO - 'USER': 'cltbld', 21:47:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:10 INFO - 'XPC_FLAGS': '0x0', 21:47:10 INFO - 'XPC_SERVICE_NAME': '0', 21:47:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:10 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 21:47:10 INFO - Cleaning up... 21:47:10 INFO - Return code: 0 21:47:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:47:10 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')]} 21:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:10 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')]} 21:47:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:10 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 0x109500a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095074c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f9d792f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a4d30>, '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 0x109208db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10939bb20>, '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.nNCK4JoVpY/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.jBz3CFuQaD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 21:47:10 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 21:47:10 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 21:47:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNCK4JoVpY/Render', 21:47:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:10 INFO - 'HOME': '/Users/cltbld', 21:47:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:10 INFO - 'LOGNAME': 'cltbld', 21:47:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:10 INFO - 'MOZ_NO_REMOTE': '1', 21:47:10 INFO - 'NO_EM_RESTART': '1', 21:47:10 INFO - 'PAGER': '/bin/cat', 21:47:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:10 INFO - 'PWD': '/builds/slave/test', 21:47:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:10 INFO - 'SHELL': '/bin/bash', 21:47:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jBz3CFuQaD/Listeners', 21:47:10 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 21:47:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:10 INFO - 'USER': 'cltbld', 21:47:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:10 INFO - 'XPC_FLAGS': '0x0', 21:47:10 INFO - 'XPC_SERVICE_NAME': '0', 21:47:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:10 INFO - Downloading/unpacking psutil>=0.7.1 21:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:47:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:47:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:47:13 INFO - Installing collected packages: psutil 21:47:13 INFO - Running setup.py install for psutil 21:47:13 INFO - building 'psutil._psutil_osx' extension 21:47:13 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 21:47:14 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 21:47:14 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 21:47:14 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 21:47:14 INFO - building 'psutil._psutil_posix' extension 21:47:14 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 21:47:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:47:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:47:14 INFO - ^ 21:47:14 INFO - 1 warning generated. 21:47:14 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 21:47:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:47:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:47:15 INFO - Successfully installed psutil 21:47:15 INFO - Cleaning up... 21:47:15 INFO - Return code: 0 21:47:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:47:15 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')]} 21:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:15 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')]} 21:47:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:15 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 0x109500a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095074c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f9d792f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a4d30>, '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 0x109208db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10939bb20>, '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.nNCK4JoVpY/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.jBz3CFuQaD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 21:47:15 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 21:47:15 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 21:47:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNCK4JoVpY/Render', 21:47:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:15 INFO - 'HOME': '/Users/cltbld', 21:47:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:15 INFO - 'LOGNAME': 'cltbld', 21:47:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:15 INFO - 'MOZ_NO_REMOTE': '1', 21:47:15 INFO - 'NO_EM_RESTART': '1', 21:47:15 INFO - 'PAGER': '/bin/cat', 21:47:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:15 INFO - 'PWD': '/builds/slave/test', 21:47:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:15 INFO - 'SHELL': '/bin/bash', 21:47:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jBz3CFuQaD/Listeners', 21:47:15 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 21:47:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:15 INFO - 'USER': 'cltbld', 21:47:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:15 INFO - 'XPC_FLAGS': '0x0', 21:47:15 INFO - 'XPC_SERVICE_NAME': '0', 21:47:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:47:15 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 21:47:15 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 21:47:15 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 21:47:15 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 21:47:15 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 21:47:15 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 21:47:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:47:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:47:18 INFO - Installing collected packages: mozsystemmonitor 21:47:18 INFO - Running setup.py install for mozsystemmonitor 21:47:18 INFO - Successfully installed mozsystemmonitor 21:47:18 INFO - Cleaning up... 21:47:18 INFO - Return code: 0 21:47:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:47:18 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')]} 21:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:18 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')]} 21:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:18 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 0x109500a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095074c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f9d792f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a4d30>, '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 0x109208db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10939bb20>, '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.nNCK4JoVpY/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.jBz3CFuQaD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 21:47:18 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 21:47:18 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 21:47:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNCK4JoVpY/Render', 21:47:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:18 INFO - 'HOME': '/Users/cltbld', 21:47:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:18 INFO - 'LOGNAME': 'cltbld', 21:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:18 INFO - 'MOZ_NO_REMOTE': '1', 21:47:18 INFO - 'NO_EM_RESTART': '1', 21:47:18 INFO - 'PAGER': '/bin/cat', 21:47:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:18 INFO - 'PWD': '/builds/slave/test', 21:47:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:18 INFO - 'SHELL': '/bin/bash', 21:47:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jBz3CFuQaD/Listeners', 21:47:18 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 21:47:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:18 INFO - 'USER': 'cltbld', 21:47:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:18 INFO - 'XPC_FLAGS': '0x0', 21:47:18 INFO - 'XPC_SERVICE_NAME': '0', 21:47:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:18 INFO - Downloading/unpacking blobuploader==1.2.4 21:47:18 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 21:47:18 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 21:47:18 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 21:47:18 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 21:47:18 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 21:47:18 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 21:47:21 INFO - Downloading blobuploader-1.2.4.tar.gz 21:47:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:47:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:47:21 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 21:47:21 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 21:47:21 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 21:47:21 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 21:47:21 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 21:47:21 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 21:47:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:47:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:47:21 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 21:47:21 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 21:47:21 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 21:47:21 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 21:47:21 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 21:47:21 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 21:47:22 INFO - Downloading docopt-0.6.1.tar.gz 21:47:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:47:22 INFO - Installing collected packages: blobuploader, requests, docopt 21:47:22 INFO - Running setup.py install for blobuploader 21:47:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:47:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:47:22 INFO - Running setup.py install for requests 21:47:23 INFO - Running setup.py install for docopt 21:47:23 INFO - Successfully installed blobuploader requests docopt 21:47:23 INFO - Cleaning up... 21:47:23 INFO - Return code: 0 21:47:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:23 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 0x109500a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095074c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f9d792f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a4d30>, '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 0x109208db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10939bb20>, '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.nNCK4JoVpY/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.jBz3CFuQaD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 21:47:23 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 21:47:23 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 21:47:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNCK4JoVpY/Render', 21:47:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:23 INFO - 'HOME': '/Users/cltbld', 21:47:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:23 INFO - 'LOGNAME': 'cltbld', 21:47:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:23 INFO - 'MOZ_NO_REMOTE': '1', 21:47:23 INFO - 'NO_EM_RESTART': '1', 21:47:23 INFO - 'PAGER': '/bin/cat', 21:47:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:23 INFO - 'PWD': '/builds/slave/test', 21:47:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:23 INFO - 'SHELL': '/bin/bash', 21:47:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jBz3CFuQaD/Listeners', 21:47:23 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 21:47:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:23 INFO - 'USER': 'cltbld', 21:47:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:23 INFO - 'XPC_FLAGS': '0x0', 21:47:23 INFO - 'XPC_SERVICE_NAME': '0', 21:47:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:47:23 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-Hb71yQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:47:23 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-cM1Gnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:47:23 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-Te_Q7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:47:23 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-zQneNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:47:23 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-zngSsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:47:24 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-MYHx0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:47:24 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-tIldNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:47:24 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-JS5q6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:47:24 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-jifVGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:47:24 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-zMLpRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:47:24 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-b3_l1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:47:24 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-OhyWP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:47:24 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-jm9zEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:47:24 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-Mhr9NG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:47:24 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-LgPGXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:47:25 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-5g6t84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:47:25 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-vWPIk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:47:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:47:25 INFO - Running setup.py install for manifestparser 21:47:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:47:25 INFO - Running setup.py install for mozcrash 21:47:25 INFO - Running setup.py install for mozdebug 21:47:25 INFO - Running setup.py install for mozdevice 21:47:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:47:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:47:25 INFO - Running setup.py install for mozfile 21:47:25 INFO - Running setup.py install for mozhttpd 21:47:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:47:26 INFO - Running setup.py install for mozinfo 21:47:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:47:26 INFO - Running setup.py install for mozInstall 21:47:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:47:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:47:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:47:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:47:26 INFO - Running setup.py install for mozleak 21:47:26 INFO - Running setup.py install for mozlog 21:47:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:47:26 INFO - Running setup.py install for moznetwork 21:47:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:47:26 INFO - Running setup.py install for mozprocess 21:47:27 INFO - Running setup.py install for mozprofile 21:47:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:47:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:47:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:47:27 INFO - Running setup.py install for mozrunner 21:47:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:47:27 INFO - Running setup.py install for mozscreenshot 21:47:27 INFO - Running setup.py install for moztest 21:47:27 INFO - Running setup.py install for mozversion 21:47:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:47:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:47:27 INFO - Cleaning up... 21:47:27 INFO - Return code: 0 21:47:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:47:27 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')]} 21:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:27 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')]} 21:47:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:27 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 0x109500a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095074c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f9d792f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a4d30>, '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 0x109208db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10939bb20>, '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.nNCK4JoVpY/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.jBz3CFuQaD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 21:47:27 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 21:47:27 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 21:47:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNCK4JoVpY/Render', 21:47:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:27 INFO - 'HOME': '/Users/cltbld', 21:47:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:27 INFO - 'LOGNAME': 'cltbld', 21:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:27 INFO - 'MOZ_NO_REMOTE': '1', 21:47:27 INFO - 'NO_EM_RESTART': '1', 21:47:27 INFO - 'PAGER': '/bin/cat', 21:47:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:27 INFO - 'PWD': '/builds/slave/test', 21:47:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:27 INFO - 'SHELL': '/bin/bash', 21:47:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jBz3CFuQaD/Listeners', 21:47:27 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 21:47:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:27 INFO - 'USER': 'cltbld', 21:47:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:27 INFO - 'XPC_FLAGS': '0x0', 21:47:27 INFO - 'XPC_SERVICE_NAME': '0', 21:47:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:47:28 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-Y2SWwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:47:28 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)) 21:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:47:28 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-VrRWr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:47:28 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)) 21:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:47:28 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-BwPXHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:47:28 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)) 21:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:47:28 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-SDgpRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:47:28 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)) 21:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:47:28 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-H3aYC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:47:28 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)) 21:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:47:28 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-pIM6zk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:47:28 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)) 21:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:47:28 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-qws6Kl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:47:28 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)) 21:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:47:28 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-Gn8aCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:47:28 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)) 21:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:47:28 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-dFAq2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:47:29 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)) 21:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:47:29 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-I_JN_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:47:29 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)) 21:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:47:29 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-S09oMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:47:29 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)) 21:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:47:29 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-ibZ8cQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:47:29 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)) 21:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:47:29 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-BIWLJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:47:29 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)) 21:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:47:29 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-V1Idsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:47:29 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)) 21:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:47:29 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-2VN_85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:47:29 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)) 21:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:47:29 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-gsCVJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:47:29 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)) 21:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:47:29 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-jEecM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:47:29 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)) 21:47:29 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)) 21:47:29 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)) 21:47:29 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)) 21:47:29 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)) 21:47:29 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)) 21:47:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:47: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 21:47: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 21:47: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 21:47: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 21:47: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 21:47: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 21:47:32 INFO - Downloading blessings-1.6.tar.gz 21:47:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:47:32 INFO - Installing collected packages: blessings 21:47:32 INFO - Running setup.py install for blessings 21:47:32 INFO - Successfully installed blessings 21:47:32 INFO - Cleaning up... 21:47:32 INFO - Return code: 0 21:47:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:47:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:47:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:47:32 INFO - Reading from file tmpfile_stdout 21:47:32 INFO - Current package versions: 21:47:32 INFO - blessings == 1.6 21:47:32 INFO - blobuploader == 1.2.4 21:47:32 INFO - docopt == 0.6.1 21:47:32 INFO - manifestparser == 1.1 21:47:32 INFO - mozInstall == 1.12 21:47:32 INFO - mozcrash == 0.17 21:47:32 INFO - mozdebug == 0.1 21:47:32 INFO - mozdevice == 0.48 21:47:32 INFO - mozfile == 1.2 21:47:32 INFO - mozhttpd == 0.7 21:47:32 INFO - mozinfo == 0.9 21:47:32 INFO - mozleak == 0.1 21:47:32 INFO - mozlog == 3.1 21:47:32 INFO - moznetwork == 0.27 21:47:32 INFO - mozprocess == 0.22 21:47:32 INFO - mozprofile == 0.28 21:47:32 INFO - mozrunner == 6.11 21:47:32 INFO - mozscreenshot == 0.1 21:47:32 INFO - mozsystemmonitor == 0.0 21:47:32 INFO - moztest == 0.7 21:47:32 INFO - mozversion == 1.4 21:47:32 INFO - psutil == 3.1.1 21:47:32 INFO - requests == 1.2.3 21:47:32 INFO - wsgiref == 0.1.2 21:47:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:47: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')]} 21:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47: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')]} 21:47:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:32 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 0x109500a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095074c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f9d792f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a4d30>, '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 0x109208db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10939bb20>, '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.nNCK4JoVpY/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.jBz3CFuQaD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 21:47:32 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 21:47:32 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 21:47:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNCK4JoVpY/Render', 21:47:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:32 INFO - 'HOME': '/Users/cltbld', 21:47:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:32 INFO - 'LOGNAME': 'cltbld', 21:47:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:32 INFO - 'MOZ_NO_REMOTE': '1', 21:47:32 INFO - 'NO_EM_RESTART': '1', 21:47:32 INFO - 'PAGER': '/bin/cat', 21:47:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:32 INFO - 'PWD': '/builds/slave/test', 21:47:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:32 INFO - 'SHELL': '/bin/bash', 21:47:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jBz3CFuQaD/Listeners', 21:47:32 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 21:47:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:32 INFO - 'USER': 'cltbld', 21:47:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:32 INFO - 'XPC_FLAGS': '0x0', 21:47:32 INFO - 'XPC_SERVICE_NAME': '0', 21:47:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:33 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)) 21:47:33 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)) 21:47:33 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)) 21:47:33 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)) 21:47:33 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)) 21:47:33 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)) 21:47:33 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)) 21:47:33 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)) 21:47:33 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)) 21:47:33 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)) 21:47:33 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)) 21:47:33 INFO - Cleaning up... 21:47:33 INFO - Return code: 0 21:47:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:47:33 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')]} 21:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:33 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')]} 21:47:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:33 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 0x109500a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095074c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f9d792f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a4d30>, '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 0x109208db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10939bb20>, '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.nNCK4JoVpY/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.jBz3CFuQaD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 21:47:33 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 21:47:33 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 21:47:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNCK4JoVpY/Render', 21:47:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:33 INFO - 'HOME': '/Users/cltbld', 21:47:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:33 INFO - 'LOGNAME': 'cltbld', 21:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:33 INFO - 'MOZ_NO_REMOTE': '1', 21:47:33 INFO - 'NO_EM_RESTART': '1', 21:47:33 INFO - 'PAGER': '/bin/cat', 21:47:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:33 INFO - 'PWD': '/builds/slave/test', 21:47:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:33 INFO - 'SHELL': '/bin/bash', 21:47:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jBz3CFuQaD/Listeners', 21:47:33 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 21:47:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:33 INFO - 'USER': 'cltbld', 21:47:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:33 INFO - 'XPC_FLAGS': '0x0', 21:47:33 INFO - 'XPC_SERVICE_NAME': '0', 21:47:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:33 INFO - Downloading/unpacking jsonschema 21:47:33 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 21:47:33 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 21:47:33 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 21:47:33 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 21:47:33 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 21:47:33 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 21:47:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:47:35 INFO - Downloading/unpacking functools32 (from jsonschema) 21:47: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 21:47: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 21:47: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 21:47: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 21:47: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 21:47: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 21:47:36 INFO - Downloading functools32-3.2.3-2.tar.gz 21:47:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:47:36 INFO - warning: no files found matching '*.txt' 21:47:36 INFO - no previously-included directories found matching 'build' 21:47:36 INFO - no previously-included directories found matching 'dist' 21:47:36 INFO - no previously-included directories found matching '.git*' 21:47:36 INFO - Installing collected packages: jsonschema, functools32 21:47:36 INFO - Running setup.py install for functools32 21:47:36 INFO - warning: no files found matching '*.txt' 21:47:36 INFO - no previously-included directories found matching 'build' 21:47:36 INFO - no previously-included directories found matching 'dist' 21:47:36 INFO - no previously-included directories found matching '.git*' 21:47:36 INFO - Successfully installed jsonschema functools32 21:47:36 INFO - Cleaning up... 21:47:36 INFO - Return code: 0 21:47:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:47:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109500a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095074c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f9d792f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093a4d30>, '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 0x109208db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10939bb20>, '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.nNCK4JoVpY/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.jBz3CFuQaD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 21:47:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 21:47:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 21:47:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNCK4JoVpY/Render', 21:47:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:36 INFO - 'HOME': '/Users/cltbld', 21:47:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:36 INFO - 'LOGNAME': 'cltbld', 21:47:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:36 INFO - 'MOZ_NO_REMOTE': '1', 21:47:36 INFO - 'NO_EM_RESTART': '1', 21:47:36 INFO - 'PAGER': '/bin/cat', 21:47:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:36 INFO - 'PWD': '/builds/slave/test', 21:47:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:36 INFO - 'SHELL': '/bin/bash', 21:47:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jBz3CFuQaD/Listeners', 21:47:36 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 21:47:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:36 INFO - 'USER': 'cltbld', 21:47:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:36 INFO - 'XPC_FLAGS': '0x0', 21:47:36 INFO - 'XPC_SERVICE_NAME': '0', 21:47:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:37 INFO - Downloading/unpacking flake8 21:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:47:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:47:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:47:40 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 21:47:40 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 21:47:40 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 21:47:40 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 21:47:40 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 21:47:40 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 21:47:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:47:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:47:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:47:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:47:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:47:40 INFO - no previously-included directories found matching 'docs/_build' 21:47:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:47:40 INFO - Running setup.py install for pep8 21:47:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:47:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:47:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:47:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:47:41 INFO - no previously-included directories found matching 'docs/_build' 21:47:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:47:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:47:41 INFO - Cleaning up... 21:47:41 INFO - Return code: 0 21:47:41 INFO - Running post-action listener: _resource_record_post_action 21:47:41 INFO - Running post-action listener: _start_resource_monitoring 21:47:41 INFO - Starting resource monitoring. 21:47:41 INFO - ##### 21:47:41 INFO - ##### Running install step. 21:47:41 INFO - ##### 21:47:41 INFO - Running pre-action listener: _resource_record_pre_action 21:47:41 INFO - Running main action method: install 21:47:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:47:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:47:41 INFO - Reading from file tmpfile_stdout 21:47:41 INFO - Detecting whether we're running mozinstall >=1.0... 21:47:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:47:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:47:41 INFO - Reading from file tmpfile_stdout 21:47:41 INFO - Output received: 21:47:41 INFO - Usage: mozinstall [options] installer 21:47:41 INFO - Options: 21:47:41 INFO - -h, --help show this help message and exit 21:47:41 INFO - -d DEST, --destination=DEST 21:47:41 INFO - Directory to install application into. [default: 21:47:41 INFO - "/builds/slave/test"] 21:47:41 INFO - --app=APP Application being installed. [default: firefox] 21:47:41 INFO - mkdir: /builds/slave/test/build/application 21:47:41 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'] 21:47:41 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 21:48:03 INFO - Reading from file tmpfile_stdout 21:48:03 INFO - Output received: 21:48:03 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 21:48:03 INFO - Running post-action listener: _resource_record_post_action 21:48:03 INFO - ##### 21:48:03 INFO - ##### Running run-tests step. 21:48:03 INFO - ##### 21:48:03 INFO - Running pre-action listener: _resource_record_pre_action 21:48:03 INFO - Running main action method: run_tests 21:48:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:48:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:48:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:48:03 INFO - 2016-05-25 21:48:03.761 screenresolution[1650:7769] starting screenresolution argv=screenresolution get 21:48:03 INFO - 2016-05-25 21:48:03.764 screenresolution[1650:7769] Display 0: 1600x1200x32@60 21:48:03 INFO - 2016-05-25 21:48:03.770 screenresolution[1651:7771] starting screenresolution argv=screenresolution list 21:48:03 INFO - Available Modes on Display 0 21:48:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:48:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:48:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:48:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:48:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:48:03 INFO - Intel Iris: 21:48:03 INFO - Chipset Model: Intel Iris 21:48:03 INFO - Type: GPU 21:48:03 INFO - Bus: Built-In 21:48:03 INFO - VRAM (Dynamic, Max): 1536 MB 21:48:03 INFO - Vendor: Intel (0x8086) 21:48:03 INFO - Device ID: 0x0a2e 21:48:03 INFO - Revision ID: 0x0009 21:48:03 INFO - Displays: 21:48:03 INFO - Display: 21:48:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:48:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:48:04 INFO - Display Serial Number: 1600x1200 60 21:48:04 INFO - Main Display: Yes 21:48:04 INFO - Mirror: Off 21:48:04 INFO - Online: Yes 21:48:04 INFO - Rotation: Supported 21:48:04 INFO - Return code: 0 21:48:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:48:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:48:04 INFO - Python 2.7.3 21:48:04 INFO - Return code: 0 21:48:04 INFO - grabbing minidump binary from tooltool 21:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:04 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 0x1093a4d30>, '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 0x109208db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10939bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:48:04 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 21:48:04 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 21:48:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:48:04 INFO - Return code: 0 21:48:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:48:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:48:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:48:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:48:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:48:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:48:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:48:05 INFO - Return code: 0 21:48:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XsF9mbzDSWG9QyCzWKof2Q/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0231', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:48:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XsF9mbzDSWG9QyCzWKof2Q/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0231 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:48:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNCK4JoVpY/Render', 21:48:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:48:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:48:05 INFO - 'HOME': '/Users/cltbld', 21:48:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:48:05 INFO - 'LOGNAME': 'cltbld', 21:48:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:48:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:05 INFO - 'MOZ_NO_REMOTE': '1', 21:48:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:48:05 INFO - 'NO_EM_RESTART': '1', 21:48:05 INFO - 'PAGER': '/bin/cat', 21:48:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:05 INFO - 'PWD': '/builds/slave/test', 21:48:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:48:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:48:05 INFO - 'SHELL': '/bin/bash', 21:48:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jBz3CFuQaD/Listeners', 21:48:05 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 21:48:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:48:05 INFO - 'USER': 'cltbld', 21:48:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:48:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:05 INFO - 'XPC_FLAGS': '0x0', 21:48:05 INFO - 'XPC_SERVICE_NAME': '0', 21:48:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:48:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XsF9mbzDSWG9QyCzWKof2Q/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0231', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:48:05 INFO - mozversion application_buildid: 20160525194948 21:48:05 INFO - mozversion application_changeset: 7c3ef5d06736bc63d138975a7194050569c62636 21:48:05 INFO - mozversion application_display_name: Firefox 21:48:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:48:05 INFO - mozversion application_name: Firefox 21:48:05 INFO - mozversion application_remotingname: firefox 21:48:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 21:48:05 INFO - mozversion application_vendor: Mozilla 21:48:05 INFO - mozversion application_version: 47.0 21:48:05 INFO - mozversion platform_buildid: 20160525194948 21:48:05 INFO - mozversion platform_changeset: 7c3ef5d06736bc63d138975a7194050569c62636 21:48:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 21:48:05 INFO - mozversion platform_version: 47.0 21:48:05 INFO - using testdate: 1464238085 21:48:05 INFO - actual date: 1464238085 21:48:05 INFO - starting webserver on 'localhost:49275' 21:48:05 INFO - SUITE-START | Running 2 tests 21:48:05 INFO - TEST-START | dromaeo_css 21:48:05 INFO - operating with platform_type : mac_ 21:48:05 INFO - Initialising browser for dromaeo_css test... 21:48:05 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmpHDLRDU/profile http://localhost:49275/getInfo.html) 21:48:08 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 21:48:08 INFO - PROCESS | 1669 | colorDepth:24 21:48:08 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 21:48:08 INFO - PROCESS | 1669 | __metrics 21:48:08 INFO - PROCESS | 1669 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:48:08 INFO - PROCESS | 1669 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:48:08 INFO - TEST-INFO | 1669: exit 0 21:48:08 INFO - Browser initialized. 21:48:08 INFO - Running cycle 1/1 for dromaeo_css test... 21:48:08 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmpHDLRDU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:48:20 INFO - PROCESS | 1672 | RSS: Main: 157376512 21:48:20 INFO - PROCESS | 1672 | 21:49:11 INFO - PROCESS | 1672 | 1464238151869 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] 21:51:21 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 21:51:23 INFO - PROCESS | 1672 | RSS: Main: 270090240 21:51:23 INFO - PROCESS | 1672 | 21:54:25 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 21:54:25 INFO - PROCESS | 1672 | RSS: Main: 287047680 21:54:25 INFO - PROCESS | 1672 | 21:57:27 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 21:57:28 INFO - PROCESS | 1672 | RSS: Main: 298991616 21:57:28 INFO - PROCESS | 1672 | 22:00:30 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 22:00:30 INFO - PROCESS | 1672 | RSS: Main: 257568768 22:00:30 INFO - PROCESS | 1672 | 22:03:33 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 22:03:34 INFO - PROCESS | 1672 | RSS: Main: 259383296 22:03:34 INFO - PROCESS | 1672 | 22:06:36 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 22:06:37 INFO - PROCESS | 1672 | RSS: Main: 306712576 22:06:37 INFO - PROCESS | 1672 | 22:06:37 INFO - PROCESS | 1672 | __start_tp_report 22:06:37 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 22:06:37 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 22:06:37 INFO - PROCESS | 1672 | |i|pagename|runs| 22:06:37 INFO - PROCESS | 1672 | |0;dojo.html;3520.4895290182926;3587.587427445841;3587.587427445843;3619.692326152276;3664.157243833918;5696.231008813809;5733.111367737997;5747.281589801275;5769.192313076167;5803.419658034194;4661;5775.2203452533895;5779.450952159538;5780.104083866997;5781.653100813955;5172.250023746555;5188.37739471264;5219.765110570014;5236.607254455912;5265.76304066318;5288.444713305105;5311.415744268127;5319.9202011969855;5324;5327.413984461726;5189.3772747270195;5251.632385733;5275.60432967529;5293.258943747878;5295.973520132394;4719.528047195287;5298.4966428189455;5331.200319952039;5350.5184533392185;5357.8392648220615;5152.227165925104;5261.105612045962;5274.5780337572905;5295.629305948585;5316.680999140064;5678.630888992244;5684.8294551163535;5696.946064977951;5698.886022279531;5748.223989761413;5123.385193776733;6165.383461653843;6268.843278918018;6306.400891915307;6320.178376810985;6236.750529978795;6249.12512248281;6251.343608921089;6255.999040153553;6265.780697675559;5969.820905372846;5993.190919225936;6000.129981152709;6000.6399616022745;6007.879842403127;6191.349908259658;6243.656598887105;6302.275238347557;6314.084457753692;6339.0808332791485;6236.844078898064;6252.562320637512;6257.405546473078;6275.309715931244;6276.340984196685;6290.056491526308;6292.590981586182;6292.874142517124;6303.212098487689;6340.239171299474;6108.633481991094;6233.3143354231;6240.282367527792;6244.219472565929;6249.6562689051625;6197.318294987548;6244.656543890039;6267.6866156692895;6275.121482992385;6323.336049714806;5004.2493625956395;5005.424376196711;5012.072766538202;5015.974920125376;5028.698278103326;4431.357453169272;4490.16931867599;4495.078508905732;4530.818767249273;4544.7727613619845;5938.6436813791315;5992.221011268507;5994.280686317583;6033.336333003366;6045.486133678599;6229.56393052482;6235.501159907287;6251.9687401562705;6267.592606480655;6271.3728627136925;5784.4504772046585;5820.650760954356;5971.2834459864225;5972.761089556369;6003.8198854034445;5404.189371594213;5452.509274165344;5469.863253418617;5480.150576660624;5499.1476321170285;6311.400416960381;6330.556861019684;6331.873362532631;6334.651594162366;6339.619622822645;6167.105769663463;6196.411340922605;6279.434850863261;6289.9056514153235;6314.8737025258315;6381.329960354282;6421.678916054085;6425.967870160619;6426.550141490238;6445.2587952386075;6204.100405441095;6256.906146407899;6275.278342990615;6279.246490421178;6282.465990390868;6156.384361563987;6189.81430557084;6213.2233470816145;6271.372862713874;6276.215473065867;6009.849753756191;6195.504359651307;6198.752049918133;6219.782307619212;6233.657148856856;6209.379062093754;6210.130581718473;6214.378562143749;6223.751049957951;6231.626102433868;5960.791372301948;6004.609700369462;6074.1799857020505;6118.710550942845;6130.754769809158;6155.815325540241;6198.132261483306;6198.845028874314;6201.069839524108;6236.875262494634;6073.331933487401;6107.69461526913;6111.633302001894;6112.510999120149;6120.204373431426 22:06:37 INFO - PROCESS | 1672 | |1;ext.html;484.38966901703884;584.4068270705233;590.2238556298468;667.9966600166998;670.885949388604;31786.523202151988;40534.797326013366;40575.391369129415;40592.39111413327;40661;35600;43449;43966.56033439664;44080.338794918025;44112;9828.901710982871;10052.195824334036;10069.798604027916;10094.9495252524;10119.645812396568;9868.45723485208;10005.849912251322;10010.849837252446;10012.69961901144;10013.04876036779;9962.701118966443;10147.340422872527;10162.187025038016;10172;10181.440020798853;10070.1440377568;10133.543990520371;10156.593736250541;10169.440680762555;10175.491225438773;9960.452175130366;10084.596616135346;10087.445190514518;10102.747431314203;10108.595656173744;42416.787916060224;42948;42966.35550466745;43090.35364469535;43141.56858431407;3258.7067163955358;3340.515625234327;3344.8494817733263;3384.120128766514;3435.278591495789;28728.42543149146;29061.85469072641;29125.56311655327;29194.854025729946;30147.849260753555;2594.9870250648814;2800.2439341377917;2832.362718388346;2835.900743473989;2935.1341354300534;497603;500174;501495;501898;502127;46980.7650961743;47831.04337913222;65417.345826541125;66750.66624666845;67036.32963670399;46488.83777905579;46666;46673.29990050152;46690;46750.766246168554;17537.824621753618;17711.822881771273;17711.911440442716;17715.468535943943;17719.29122835098;14183.574492765234;14262.286885655676;14268.928655356656;14273.85726142746;14276.21480818565;15242.390304387922;15267.541973740805;15284.388624454898;15316.463923762614;15405.691886162214;6337.084940927133;6474.773382931575;6502.479801615859;6506.446952009038;6519.902201466982;974.3471873844542;1008.0826447932493;1025.7538190834296;1130.7371555480797;1178.3695722788439;30209.942652007074;30218.84890575533;30772.230694232825;30826.69173308283;30845;942.0532364973158;1095.3318475729798;1131.3042478875598;1216.391804097951;1256.7298030923396;15395.384184632489;15446;15485.612859678598;15487.845121548866;15827.446039388566;533598;539494;541004;548181;548713;59843.803123938145;60216.397836021955;60472.39527604756;60513.09230361548;60693.08960365598;1401.3133564553295;1502.9098254104788;1507.3593722667822;1522.6117340078208;1531.992340038315;25271.512322386003;28992.855035724686;29063;30497.23756906095;31049.68950310468;48600.5139948596;48641.75679121723;49202.753986229836;49208.01583968372;49324.506754931994;366897.1655141814;367872;368432.3156768398;370031;370175;30082;34361.140971475914;34838.82580587081;34959.65040349564;35341.586336547276;41894.790526047174;43329.783351083046;43444.782776085915;43529.78235108804;44241.55758442375;34433.31133377369;35737.64262357447;35811.64188358083;36042.8197859009;36354.45468317925;36940.076498087765;37103.81448092742;37318.81340593279;37516.62483375131;37526.81236593799;29448.263793405335;36832.63167368292;37422.25155496929;37451.625483744814;37834.81082594569;31123.84438077795;32447;32749.69001239924;32840.014799556055;32997.50503742494;19727.605447890674;23409.829508524166;23601.0559577615;23829.880850595637;24041.398965025313 22:06:37 INFO - PROCESS | 1672 | |2;jquery.html;388.81336958260033;392.95088113985753;393.58869980869986;402.2337447163155;403.2580052703026;20220.89889550552;21766.238181663644;21885;22163;22228.333150005485;21695.132194712194;21801;22404.439889002784;22434.551308973852;22666.66000010001;5935.792247271346;5997.6701281429505;6174.660393678346;6185.103160041791;6217.285012223607;6107.541934354919;6154;6173.475254603341;6174.135621013062;6178.938210617904;5856.824295271149;6045.093236014589;6071.3625069367745;6120.051392034219;6124.418180272867;5909.793157239476;6040.697965101749;6070.271567411917;6073.423024812636;6111.327753947062;5714.599978001542;5750.45370689788;5754.654720716729;5843.094320380348;5860.267466566679;13902.374393152231;14038.508652197124;14247.572572822832;16030;22764.658530121895;2310.676505289261;2317.5480781247666;2324.1865347128537;2348.178137651825;2377.037299893546;9988.05113514215;10112.191024718006;10566.260361774679;13224.6693832654;14712.55862324132;1702.8978261304362;1722.1389305347327;1724.1896308734874;1732.7314266288745;1738.6522695460833;103011.96988030174;103490.96509034888;105895.47052264767;106218;106424;11435.542578296941;11500.884991149982;11589.99999999983;11592.88407115918;11732.530698772125;11766.705832354259;14346.713065738626;14377.137371757728;14387.78418323726;14389.856101439062;8764.123587641185;8927.419717718327;8936.776580585407;9037.683681071263;9044.954775226082;9205.677801276923;9208.63165473387;9243.90756092444;9275.072492750805;9312.161905428544;3599.7300202484917;4409.2724700424715;4491.752953587584;4528.45658520973;4617.307403889444;1872.2587993166214;1924;1927.354336297328;1955.1104247567323;1977.9714548434733;739.7780665800238;814.3647954595425;832.650286879512;900.8063266397756;952.538019060755;20048.69926951097;20783.584328313653;21004.65292944625;21510.784892150878;21848.01683924227;955.6129767444196;1001.2540657210425;1017.2624846986024;1058.655936820521;1069.903708666208;10974.506147223394;11415.315081095161;11427.971482566443;11452.885471145182;11468.4839182237;283150;648903;651591;663791;682896;101295.49352253339;113017.43491282492;117696.41151794358;128871.35564322305;131058;1070.4273213830718;1083.5124194112682;1099.054812860923;1100.5542755184163;1105.1379923659558;18600.813991859908;19032.858028518334;19288.90355548213;19342.516437089187;19627.11677974466;37181.25637487289;53584.732076339365;54200.91598168093;54295.82816687288;54755.452445475035;61078.38921610905;70897.6455117721;77241;79575.20424795678;80369.1963080385;7877.842443151219;8050.235227653364;8294.087650358577;8316.542590157358;8497.787555311166;10047.899521004696;13445.529406470727;13729.45082196701;13817.516386926409;13859.307034648025;11715.531378744754;11757.529698811952;11802.76394472123;11846.585369512026;12151.878481215075;11610;11680.240784348991;11701;11945.581904633296;12130.454129564367;6198.845028874314;10859.457027148768;11013.449327533752;11631.011364034151;12034.518619255132;8359.707410240855;8367.121452247426;8498.61756220984;8563.400561960603;8781.253593444373;11663.300201987568;11897;11898.821517677416;12079.214851034654;12090.697732556757 22:06:37 INFO - PROCESS | 1672 | |3;mootools.html;1484.5768955847586;1603.863671587915;1610.7342288522395;1928.5853541488577;2073.5023594337354;8265.380096492765;8818.07410221927;8978.102189781019;8988.820223595541;9000.549972501381;8476.15238476152;8694.782630434242;8695.56522173892;8709.388763078834;8739.86890196646;2535.2267558394683;2536.6702328697243;2536.8604726740023;2538.4796116796015;2581.90963316284;2460.766227208412;2545.7963362930923;2547.8726063696836;2550.41340491687;2556.5526032944254;2515.8490490570534;2532.708738495069;2534.911278105267;2535.936601584966;2538.530371881199;2078.688196770481;2485.72657007729;2504.7119581248207;2507.4859653771023;2532.113760183939;2517.1819158773474;2525.5454018276705;2525.911593094251;2525.9747402525923;2532.683414573178;8849.646014159425;8887.466751994836;8890.955545222298;8891.911080889238;8910.242629376511;5583.8883222335735;5707.6290041147195;5746.281714785652;5749.540036797046;5759.913601295984;3654.903528941307;3731.3470142724914;3790.5451345838674;3795.6394142556414;3803.7147213959065;1062.219268837404;1077.4343469678404;1077.8491011258352;1087.613897066538;1112.1380929779405;12286.508539658404;12310.015198784076;12315.014798816073;12348.073894457862;12353.62939111828;4874.2201247800185;4920.901581968341;4951.430585482643;4996.7001979881325;5013.824516141991;10415.854256031831;10417.843732344021;10422.895771042193;10427.739306517245;10432;5645.491905728504;5685.346185188756;5695.373508914016;5702.173184888168;5779.393163717833;4537.500874903758;4711.811527538928;4911.287863259808;5102.158143906288;5155.123628983082;3974.125692347679;4026.6778657707314;4030.1738143680477;4065.7560546367313;4087.89780255496;1345.4954392102961;1356.0914187494402;1366.794980752895;1373.9763875912508;1379.6206043338161;1417.8085958395484;1431.8639729225706;1456.4829485532696;1457.8615031571983;1463.8462961389114;8405.579721014046;8503.362247831437;8505.192006759347;8522.275606573387;8557.400981931205;464.59348070438364;521.9045532188267;527.3803281144716;534.834201397568;541.3963430774658;6298.968505157445;6310.8422289442215;6350.491960643138;6352.904706429407;6356.4279214870885;10735.89264107349;11197.832032519518;11241.775164496665;11257.324560526395;11289.548418063185;10623.36259824413;10953.945230273797;10992.560297588167;11044.558217671203;11090.722731931766;8515.19105684959;8528.701495447629;8587.871181932276;8589.914100859036;8613.310935125175;7934.960325198337;8064.758057258292;8083.312918402002;8089.069756978023;8157.584734599931;9604.991475895209;9790.804183916423;9885.851712224467;10011.349262297927;10012.59949602037;9887.604495820087;10217.795644087226;10296.948515257376;10299.97000299964;10410.583576657153;7597.012388389474;7608.695652173851;7618.314351708373;7667.079950405987;7668.309852113337;8300.709475168582;8352.958235208785;8397.328213742763;8411.8738218928;8413.158684131538;7471.290227428385;7580.128285247267;7632.580208088609;7730.497517661334;7751.186125456746;7356.448266379936;7431.665575049244;7447.478676492594;7549.7357592483995;7549.811254718676;6527.477801775942;7659.851022346693;7669.1947345527915;7700.422468314787;7752.573608451364;6891.207511136284;7101.11236095488;7129.25142860013;7159;7188.676509557187;7236.855262894818;7252.782416527512;7273.3817625500305;7277.454190935595;7279.890801638086 22:06:37 INFO - PROCESS | 1672 | |4;prototype.html;337.31188375713543;339.6620362739075;345.82190172061394;349.41647448760574;354.2419222863072;6279;6758.256591774901;6784.253732089466;6817.181938167427;6822.215445223795;5797.391273916231;6372.821028109803;6717.126773519436;6785.796426107212;6799.354061364174;4839.177339852216;4925.950740492585;4997.450280469146;5041.8235361762345;5088.287639730432;4142.647874930634;4836.645739193032;5017.824376146836;5036.370453693288;5045.268436076767;4373.540778218289;5025.04524140414;5043.722595257259;5048.6465947383695;5054.646174767768;4812.855614331575;4890.193118135503;4987.850364489072;5000.549950504472;5003.099442100421;4317.9421041844635;4337.891552711208;4338.891527711801;4366.956330436687;4372.519022907478;6519.8044058678315;6520.706568204442;6522.445592124675;6524.249711283168;6557.2131344239;5974.880502389971;5977.073553599199;5978.940210597882;5986.281646202484;5989.2812862456785;6954.582725036514;7243.275672432767;7243.311885370934;7247.818804529877;7269.382102521292;4818.951810481885;4869.63477739171;4871.098846713369;4871.318015477836;4884.926726099111;7591.3926885849;7660.2722741339485;7664.271894170045;7672.46292759507;7674.1942096079665;4972.90054198914;4987.351644286219;4991.775370108281;4995.700257984533;5006.098902197639;4137.482814648169;5041.747912604355;5042.621803364762;5051.797928082909;5053.747312634354;5787.971060144672;5904.439078287556;5964.075568286922;5964.433378829004;5983.850403739942;7191.3887319578425;7257.49197556166;7268.636568171676;7284.380827629605;7296.744613938593;1739.9130043497773;1760.3662681434673;1765.2762367429293;1766.0110338210643;1768.6727955328306;1063.872335319751;1119.8712148103073;1122.421952694363;1132.6771870017005;1158.8609366876028;6294.622322660655;6850.040994260808;6870.793876183722;6891.448684105259;6919.273476284918;7426.814329641694;7434.881058898296;7443.739469118555;7452.292032256927;7472.215417381205;6852.931470685229;6856.314368563104;6862.416694580917;6862.656867156622;6881.380675739108;3855.9036024099623;3923.7645741255615;3960.6435420812263;3967.3850553164307;3973.5033120859894;7859.449838511249;7861;7901;7906;7933.127355990837;7760.029996250469;7768.961155194301;7771.961140194263;7789.792582149776;7800.9219907801335;7897.644605992629;7916.089649690244;7924.48490848093;7926.405519585939;7931.841363172589;6131.724072416663;7287.817804554928;7354.117505899327;7538.208488108889;7560.470767046254;7403.629818509161;7419.07261592301;7427.22014188524;7454.962725186339;7469.327760501581;6866.4506839453725;7894.565798880887;7895.565743884142;7927.484713493604;7948.761537153895;3940.527136743609;4732.20799728162;4775.092732380836;4786.44955830084;4789.928151077806;7240.637968101469;7510.8497830042;7521.05986751656;7534.510256833289;7541.660625271767;7245.5652660840515;7273.599952002479;7298.197198308288;7305.452091093083;7309.744158954411;5785.652860828363;7276.163241227115;7276.527025743309;7282.563046217244;7287.635618219174;6547.6577301654;6680.365365290289;7100.680469378787;7133.144022717307;7165.713371465083;5879.676617786063;7034.788956331318;7289.744858929912;7308.269173082649;7309.049823523121;6861.245263020964;7071;7079.646017699198;7080.504364694628;7111.431085513043 22:06:37 INFO - PROCESS | 1672 | |5;yui.html;719.780466957578;735.2830989784957;751.6282783919348;795.9164287749785;827.5407149032288;15164.924175379121;15211.23943802811;15444;15477.148756818384;15479.690406191869;14052.227127507984;14130.152190868555;14143.646408839784;14144.646383840409;14147;821.40858581821;832.9750107496754;955.8948515663288;958.1999030809283;994.9950549944535;976.3458482816494;976.7802244494967;978.4325091446943;981.6269817469351;982.1013772398247;1051.8474821150928;1055.0082922053284;1057.6562617149418;1058.0794708603526;1061.4533515239618;856.3620103023256;894.6019021535419;1042.781015986636;1046.6650671785033;1047.1988928469727;774.3263360876017;774.4849674966141;775.678093591159;776.5534817479916;777.8016605765494;15301.846981530265;15326.540203793904;15347;15351.616209594738;15360.846391536053;12932.741345173044;12987.480500779957;13213.207207567577;13237.470501179941;13382.598522044354;10294.073533382032;10330.380177189392;10470.738231544196;10658.094062004739;10962.232643714942;3530.188056746937;3576.4635304704243;3616.8191590420374;3647.9817600911824;3666.32173047987;82326;82700.58649706712;83103.5844820778;83694;86765.69851452233;9669.323147379617;9724.513774311397;9854.310198286052;9858.211343092678;9861.950690246504;21942.89028554847;22237.888810555844;22273.888630556743;22283;22572.0971161155;7816.101148367897;7973.960130199312;7990.840183196304;8159.67361305553;8196.67213311461;4242.745435273893;4270.35944608305;4296.419983302277;4408.889777755582;4617.422822147231;3707.8516859325323;3766.246750649881;3768.8680896168503;3769.2273084018257;3770.208256266215;621.1087090025827;631.7125707802938;643.7392855893277;655.790147152916;662.211967758366;598.9940100599025;608.9604175728564;617.8733359661348;626.3235705438207;628.8773689130576;8437.520227443585;8628.956855215683;8657.783555411164;8665.523396213268;8724.214820666044;560.5095541401274;599.7001499250375;604.9969750151221;618.9102580125947;631.3024108360288;2898.3623602807347;3902.551206611276;4053.2298863215897;4131.586841315904;4182.832686692559;93886;95154.52422737842;97134.51432742791;97447;97626.02373976169;78735.85056597786;80779.59610201912;80930.78603820948;81833.59083204666;82433.17566824376;69702.65148674224;70234.64882675656;71431.6428417865;71446.285537145;72358.27641723516;7763.2236776321915;7847.176046515034;7855.332296754611;8104.878426823484;8123.71566995176;51232;51448.48551514437;51673.48326516837;51885.62743421666;52968.73515632397;68073.31926680669;70390.64804676149;70441;70506.94239586308;70997.15555466634;11139.72150696239;11141.888581114084;11193.104551636012;11347.20569560123;11572.305661660328;11827.645170644895;12198.634040978784;12416.849243092764;12455.93772031134;12550.560730374758;11549.942250288696;11733.647990560297;11904.096462509026;11950.581729639769;12182.269063856196;11662.825057623973;11788.469518871843;11917.40412979365;12074.215176013531;12242.510299587917;11537.368003631089;11541;11712.765744685228;11745.001674857733;11924.940375298069;9746;9830.557624906753;9873.25950553697;9925.950370248103;9937.701868943943;9818.803623927624;9826.312158149147;9861.457619830979;9923.35498192644;10038.146757525692 22:06:37 INFO - PROCESS | 1672 | __end_tp_report 22:06:37 INFO - PROCESS | 1672 | __start_cc_report 22:06:37 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,1000 22:06:37 INFO - PROCESS | 1672 | __end_cc_report 22:06:37 INFO - PROCESS | 1672 | __startTimestamp1464239197104__endTimestamp 22:06:37 INFO - PROCESS | 1672 | 22:06:37 INFO - PROCESS | 1672 | ------- Summary: start ------- 22:06:37 INFO - PROCESS | 1672 | Number of tests: 6 22:06:37 INFO - PROCESS | 1672 | 22:06:37 INFO - PROCESS | 1672 | [#0] dojo.html Cycles:165 Average:5813.15 Median:6108.63 stddev:627.10 (10.3%) stddev-sans-first:602.68 22:06:37 INFO - PROCESS | 1672 | Values: 3520.5 3587.6 3587.6 3619.7 3664.2 5696.2 5733.1 5747.3 5769.2 5803.4 4661.0 5775.2 5779.5 5780.1 5781.7 5172.3 5188.4 5219.8 5236.6 5265.8 5288.4 5311.4 5319.9 5324.0 5327.4 5189.4 5251.6 5275.6 5293.3 5296.0 4719.5 5298.5 5331.2 5350.5 5357.8 5152.2 5261.1 5274.6 5295.6 5316.7 5678.6 5684.8 5696.9 5698.9 5748.2 5123.4 6165.4 6268.8 6306.4 6320.2 6236.8 6249.1 6251.3 6256.0 6265.8 5969.8 5993.2 6000.1 6000.6 6007.9 6191.3 6243.7 6302.3 6314.1 6339.1 6236.8 6252.6 6257.4 6275.3 6276.3 6290.1 6292.6 6292.9 6303.2 6340.2 6108.6 6233.3 6240.3 6244.2 6249.7 6197.3 6244.7 6267.7 6275.1 6323.3 5004.2 5005.4 5012.1 5016.0 5028.7 4431.4 4490.2 4495.1 4530.8 4544.8 5938.6 5992.2 5994.3 6033.3 6045.5 6229.6 6235.5 6252.0 6267.6 6271.4 5784.5 5820.7 5971.3 5972.8 6003.8 5404.2 5452.5 5469.9 5480.2 5499.1 6311.4 6330.6 6331.9 6334.7 6339.6 6167.1 6196.4 6279.4 6289.9 6314.9 6381.3 6421.7 6426.0 6426.6 6445.3 6204.1 6256.9 6275.3 6279.2 6282.5 6156.4 6189.8 6213.2 6271.4 6276.2 6009.8 6195.5 6198.8 6219.8 6233.7 6209.4 6210.1 6214.4 6223.8 6231.6 5960.8 6004.6 6074.2 6118.7 6130.8 6155.8 6198.1 6198.8 6201.1 6236.9 6073.3 6107.7 6111.6 6112.5 6120.2 22:06:37 INFO - PROCESS | 1672 | 22:06:37 INFO - PROCESS | 1672 | [#1] ext.html Cycles:180 Average:61401.59 Median:3409.70 stddev:126685.15 (3715.4%) stddev-sans-first:126957.98 22:06:37 INFO - PROCESS | 1672 | Values: 484.4 584.4 590.2 668.0 670.9 31786.5 40534.8 40575.4 40592.4 40661.0 35600.0 43449.0 43966.6 44080.3 44112.0 9828.9 10052.2 10069.8 10094.9 10119.6 9868.5 10005.8 10010.8 10012.7 10013.0 9962.7 10147.3 10162.2 10172.0 10181.4 10070.1 10133.5 10156.6 10169.4 10175.5 9960.5 10084.6 10087.4 10102.7 10108.6 42416.8 42948.0 42966.4 43090.4 43141.6 3258.7 3340.5 3344.8 3384.1 3435.3 28728.4 29061.9 29125.6 29194.9 30147.8 2595.0 2800.2 2832.4 2835.9 2935.1 497603.0 500174.0 501495.0 501898.0 502127.0 46980.8 47831.0 65417.3 66750.7 67036.3 46488.8 46666.0 46673.3 46690.0 46750.8 17537.8 17711.8 17711.9 17715.5 17719.3 14183.6 14262.3 14268.9 14273.9 14276.2 15242.4 15267.5 15284.4 15316.5 15405.7 6337.1 6474.8 6502.5 6506.4 6519.9 974.3 1008.1 1025.8 1130.7 1178.4 30209.9 30218.8 30772.2 30826.7 30845.0 942.1 1095.3 1131.3 1216.4 1256.7 15395.4 15446.0 15485.6 15487.8 15827.4 533598.0 539494.0 541004.0 548181.0 548713.0 59843.8 60216.4 60472.4 60513.1 60693.1 1401.3 1502.9 1507.4 1522.6 1532.0 25271.5 28992.9 29063.0 30497.2 31049.7 48600.5 48641.8 49202.8 49208.0 49324.5 366897.2 367872.0 368432.3 370031.0 370175.0 30082.0 34361.1 34838.8 34959.7 35341.6 41894.8 43329.8 43444.8 43529.8 44241.6 34433.3 35737.6 35811.6 36042.8 36354.5 36940.1 37103.8 37318.8 37516.6 37526.8 29448.3 36832.6 37422.3 37451.6 37834.8 31123.8 32447.0 32749.7 32840.0 32997.5 19727.6 23409.8 23601.1 23829.9 24041.4 22:06:37 INFO - PROCESS | 1672 | 22:06:37 INFO - PROCESS | 1672 | [#2] jquery.html Cycles:180 Average:33902.71 Median:22024.00 stddev:100604.57 (456.8%) stddev-sans-first:100855.32 22:06:37 INFO - PROCESS | 1672 | Values: 388.8 393.0 393.6 402.2 403.3 20220.9 21766.2 21885.0 22163.0 22228.3 21695.1 21801.0 22404.4 22434.6 22666.7 5935.8 5997.7 6174.7 6185.1 6217.3 6107.5 6154.0 6173.5 6174.1 6178.9 5856.8 6045.1 6071.4 6120.1 6124.4 5909.8 6040.7 6070.3 6073.4 6111.3 5714.6 5750.5 5754.7 5843.1 5860.3 13902.4 14038.5 14247.6 16030.0 22764.7 2310.7 2317.5 2324.2 2348.2 2377.0 9988.1 10112.2 10566.3 13224.7 14712.6 1702.9 1722.1 1724.2 1732.7 1738.7 103012.0 103491.0 105895.5 106218.0 106424.0 11435.5 11500.9 11590.0 11592.9 11732.5 11766.7 14346.7 14377.1 14387.8 14389.9 8764.1 8927.4 8936.8 9037.7 9045.0 9205.7 9208.6 9243.9 9275.1 9312.2 3599.7 4409.3 4491.8 4528.5 4617.3 1872.3 1924.0 1927.4 1955.1 1978.0 739.8 814.4 832.7 900.8 952.5 20048.7 20783.6 21004.7 21510.8 21848.0 955.6 1001.3 1017.3 1058.7 1069.9 10974.5 11415.3 11428.0 11452.9 11468.5 283150.0 648903.0 651591.0 663791.0 682896.0 101295.5 113017.4 117696.4 128871.4 131058.0 1070.4 1083.5 1099.1 1100.6 1105.1 18600.8 19032.9 19288.9 19342.5 19627.1 37181.3 53584.7 54200.9 54295.8 54755.5 61078.4 70897.6 77241.0 79575.2 80369.2 7877.8 8050.2 8294.1 8316.5 8497.8 10047.9 13445.5 13729.5 13817.5 13859.3 11715.5 11757.5 11802.8 11846.6 12151.9 11610.0 11680.2 11701.0 11945.6 12130.5 6198.8 10859.5 11013.4 11631.0 12034.5 8359.7 8367.1 8498.6 8563.4 8781.3 11663.3 11897.0 11898.8 12079.2 12090.7 22:06:37 INFO - PROCESS | 1672 | 22:06:37 INFO - PROCESS | 1672 | [#3] mootools.html Cycles:180 Average:6205.94 Median:5128.64 stddev:3290.92 (64.2%) stddev-sans-first:3281.01 22:06:37 INFO - PROCESS | 1672 | Values: 1484.6 1603.9 1610.7 1928.6 2073.5 8265.4 8818.1 8978.1 8988.8 9000.5 8476.2 8694.8 8695.6 8709.4 8739.9 2535.2 2536.7 2536.9 2538.5 2581.9 2460.8 2545.8 2547.9 2550.4 2556.6 2515.8 2532.7 2534.9 2535.9 2538.5 2078.7 2485.7 2504.7 2507.5 2532.1 2517.2 2525.5 2525.9 2526.0 2532.7 8849.6 8887.5 8891.0 8891.9 8910.2 5583.9 5707.6 5746.3 5749.5 5759.9 3654.9 3731.3 3790.5 3795.6 3803.7 1062.2 1077.4 1077.8 1087.6 1112.1 12286.5 12310.0 12315.0 12348.1 12353.6 4874.2 4920.9 4951.4 4996.7 5013.8 10415.9 10417.8 10422.9 10427.7 10432.0 5645.5 5685.3 5695.4 5702.2 5779.4 4537.5 4711.8 4911.3 5102.2 5155.1 3974.1 4026.7 4030.2 4065.8 4087.9 1345.5 1356.1 1366.8 1374.0 1379.6 1417.8 1431.9 1456.5 1457.9 1463.8 8405.6 8503.4 8505.2 8522.3 8557.4 464.6 521.9 527.4 534.8 541.4 6299.0 6310.8 6350.5 6352.9 6356.4 10735.9 11197.8 11241.8 11257.3 11289.5 10623.4 10953.9 10992.6 11044.6 11090.7 8515.2 8528.7 8587.9 8589.9 8613.3 7935.0 8064.8 8083.3 8089.1 8157.6 9605.0 9790.8 9885.9 10011.3 10012.6 9887.6 10217.8 10296.9 10300.0 10410.6 7597.0 7608.7 7618.3 7667.1 7668.3 8300.7 8353.0 8397.3 8411.9 8413.2 7471.3 7580.1 7632.6 7730.5 7751.2 7356.4 7431.7 7447.5 7549.7 7549.8 6527.5 7659.9 7669.2 7700.4 7752.6 6891.2 7101.1 7129.3 7159.0 7188.7 7236.9 7252.8 7273.4 7277.5 7279.9 22:06:37 INFO - PROCESS | 1672 | 22:06:37 INFO - PROCESS | 1672 | [#4] prototype.html Cycles:180 Average:5940.13 Median:6771.26 stddev:1886.94 (27.9%) stddev-sans-first:1844.78 22:06:37 INFO - PROCESS | 1672 | Values: 337.3 339.7 345.8 349.4 354.2 6279.0 6758.3 6784.3 6817.2 6822.2 5797.4 6372.8 6717.1 6785.8 6799.4 4839.2 4926.0 4997.5 5041.8 5088.3 4142.6 4836.6 5017.8 5036.4 5045.3 4373.5 5025.0 5043.7 5048.6 5054.6 4812.9 4890.2 4987.9 5000.5 5003.1 4317.9 4337.9 4338.9 4367.0 4372.5 6519.8 6520.7 6522.4 6524.2 6557.2 5974.9 5977.1 5978.9 5986.3 5989.3 6954.6 7243.3 7243.3 7247.8 7269.4 4819.0 4869.6 4871.1 4871.3 4884.9 7591.4 7660.3 7664.3 7672.5 7674.2 4972.9 4987.4 4991.8 4995.7 5006.1 4137.5 5041.7 5042.6 5051.8 5053.7 5788.0 5904.4 5964.1 5964.4 5983.9 7191.4 7257.5 7268.6 7284.4 7296.7 1739.9 1760.4 1765.3 1766.0 1768.7 1063.9 1119.9 1122.4 1132.7 1158.9 6294.6 6850.0 6870.8 6891.4 6919.3 7426.8 7434.9 7443.7 7452.3 7472.2 6852.9 6856.3 6862.4 6862.7 6881.4 3855.9 3923.8 3960.6 3967.4 3973.5 7859.4 7861.0 7901.0 7906.0 7933.1 7760.0 7769.0 7772.0 7789.8 7800.9 7897.6 7916.1 7924.5 7926.4 7931.8 6131.7 7287.8 7354.1 7538.2 7560.5 7403.6 7419.1 7427.2 7455.0 7469.3 6866.5 7894.6 7895.6 7927.5 7948.8 3940.5 4732.2 4775.1 4786.4 4789.9 7240.6 7510.8 7521.1 7534.5 7541.7 7245.6 7273.6 7298.2 7305.5 7309.7 5785.7 7276.2 7276.5 7282.6 7287.6 6547.7 6680.4 7100.7 7133.1 7165.7 5879.7 7034.8 7289.7 7308.3 7309.0 6861.2 7071.0 7079.6 7080.5 7111.4 22:06:37 INFO - PROCESS | 1672 | 22:06:37 INFO - PROCESS | 1672 | [#5] yui.html Cycles:180 Average:18909.36 Median:599.35 stddev:26591.65 (4436.8%) stddev-sans-first:26631.17 22:06:37 INFO - PROCESS | 1672 | Values: 719.8 735.3 751.6 795.9 827.5 15164.9 15211.2 15444.0 15477.1 15479.7 14052.2 14130.2 14143.6 14144.6 14147.0 821.4 833.0 955.9 958.2 995.0 976.3 976.8 978.4 981.6 982.1 1051.8 1055.0 1057.7 1058.1 1061.5 856.4 894.6 1042.8 1046.7 1047.2 774.3 774.5 775.7 776.6 777.8 15301.8 15326.5 15347.0 15351.6 15360.8 12932.7 12987.5 13213.2 13237.5 13382.6 10294.1 10330.4 10470.7 10658.1 10962.2 3530.2 3576.5 3616.8 3648.0 3666.3 82326.0 82700.6 83103.6 83694.0 86765.7 9669.3 9724.5 9854.3 9858.2 9862.0 21942.9 22237.9 22273.9 22283.0 22572.1 7816.1 7974.0 7990.8 8159.7 8196.7 4242.7 4270.4 4296.4 4408.9 4617.4 3707.9 3766.2 3768.9 3769.2 3770.2 621.1 631.7 643.7 655.8 662.2 599.0 609.0 617.9 626.3 628.9 8437.5 8629.0 8657.8 8665.5 8724.2 560.5 599.7 605.0 618.9 631.3 2898.4 3902.6 4053.2 4131.6 4182.8 93886.0 95154.5 97134.5 97447.0 97626.0 78735.9 80779.6 80930.8 81833.6 82433.2 69702.7 70234.6 71431.6 71446.3 72358.3 7763.2 7847.2 7855.3 8104.9 8123.7 51232.0 51448.5 51673.5 51885.6 52968.7 68073.3 70390.6 70441.0 70506.9 70997.2 11139.7 11141.9 11193.1 11347.2 11572.3 11827.6 12198.6 12416.8 12455.9 12550.6 11549.9 11733.6 11904.1 11950.6 12182.3 11662.8 11788.5 11917.4 12074.2 12242.5 11537.4 11541.0 11712.8 11745.0 11924.9 9746.0 9830.6 9873.3 9926.0 9937.7 9818.8 9826.3 9861.5 9923.4 10038.1 22:06:37 INFO - PROCESS | 1672 | -------- Summary: end -------- 22:06:37 INFO - PROCESS | 1672 | 22:06:37 INFO - TEST-INFO | 1672: exit 0 22:06:37 INFO - TEST-OK | dromaeo_css | took 1112146ms 22:06:37 INFO - TEST-START | kraken 22:06:37 INFO - operating with platform_type : mac_ 22:06:37 INFO - Initialising browser for kraken test... 22:06:37 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmp9aIGKa/profile http://localhost:49275/getInfo.html) 22:06:39 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 22:06:39 INFO - PROCESS | 1677 | colorDepth:24 22:06:39 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 22:06:39 INFO - PROCESS | 1677 | __metrics 22:06:39 INFO - PROCESS | 1677 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:06:39 INFO - PROCESS | 1677 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:06:40 INFO - TEST-INFO | 1677: exit 0 22:06:40 INFO - Browser initialized. 22:06:40 INFO - Running cycle 1/1 for kraken test... 22:06:40 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmp9aIGKa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:06:52 INFO - PROCESS | 1680 | RSS: Main: 157409280 22:06:52 INFO - PROCESS | 1680 | 22:06:54 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 22:06:55 INFO - PROCESS | 1680 | RSS: Main: 218361856 22:06:55 INFO - PROCESS | 1680 | 22:06:58 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 22:06:58 INFO - PROCESS | 1680 | RSS: Main: 228892672 22:06:58 INFO - PROCESS | 1680 | 22:07:01 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 22:07:02 INFO - PROCESS | 1680 | RSS: Main: 218554368 22:07:02 INFO - PROCESS | 1680 | 22:07:04 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 22:07:04 INFO - PROCESS | 1680 | RSS: Main: 220364800 22:07:04 INFO - PROCESS | 1680 | 22:07:06 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:07:07 INFO - PROCESS | 1680 | RSS: Main: 220278784 22:07:07 INFO - PROCESS | 1680 | 22:07:10 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 22:07:10 INFO - PROCESS | 1680 | RSS: Main: 220205056 22:07:10 INFO - PROCESS | 1680 | 22:07:13 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 22:07:14 INFO - PROCESS | 1680 | RSS: Main: 220274688 22:07:14 INFO - PROCESS | 1680 | 22:07:16 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 22:07:17 INFO - PROCESS | 1680 | RSS: Main: 220598272 22:07:17 INFO - PROCESS | 1680 | 22:07:18 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:07:19 INFO - PROCESS | 1680 | RSS: Main: 255459328 22:07:19 INFO - PROCESS | 1680 | 22:07:21 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:07:21 INFO - PROCESS | 1680 | RSS: Main: 256446464 22:07:21 INFO - PROCESS | 1680 | 22:07:24 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:07:24 INFO - PROCESS | 1680 | RSS: Main: 261382144 22:07:24 INFO - PROCESS | 1680 | 22:07:27 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:07:27 INFO - PROCESS | 1680 | RSS: Main: 262668288 22:07:27 INFO - PROCESS | 1680 | 22:07:30 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:07:30 INFO - PROCESS | 1680 | RSS: Main: 262524928 22:07:30 INFO - PROCESS | 1680 | 22:07:32 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 22:07:32 INFO - PROCESS | 1680 | RSS: Main: 325120000 22:07:32 INFO - PROCESS | 1680 | 22:07:32 INFO - PROCESS | 1680 | __start_tp_report 22:07:32 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 22:07:32 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 22:07:32 INFO - PROCESS | 1680 | |i|pagename|runs| 22:07:32 INFO - PROCESS | 1680 | |0;ai-astar;110;111;110;112;112;112;128;110;110;111 22:07:32 INFO - PROCESS | 1680 | |1;audio-beat-detection;181;159;173;154;127;139;121;153;149;116 22:07:32 INFO - PROCESS | 1680 | |2;audio-dft;183;184;185;184;185;182;183;183;190;183 22:07:32 INFO - PROCESS | 1680 | |3;audio-fft;70;75;75;115;55;59;57;57;118;58 22:07:32 INFO - PROCESS | 1680 | |4;audio-oscillator;87;92;130;78;80;82;119;76;79;118 22:07:32 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;86;83;87;82;86;83;85;83;86;82 22:07:32 INFO - PROCESS | 1680 | |6;imaging-darkroom;92;92;93;92;92;91;92;100;122;91 22:07:32 INFO - PROCESS | 1680 | |7;imaging-desaturate;99;119;83;85;84;85;86;83;85;84 22:07:32 INFO - PROCESS | 1680 | |8;json-parse-financial;56;57;56;56;57;56;56;56;67;52 22:07:32 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;63;70;63;71;69;66;64;65;65;65 22:07:32 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;83;80;81;80;81;82;101;67;80;100 22:07:32 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;120;131;132;118;118;110;135;131;133;113 22:07:32 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;131;129;132;117;132;121;134;132;134;133 22:07:32 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;65;68;73;96;92;95;74;64;66;65 22:07:32 INFO - PROCESS | 1680 | __end_tp_report 22:07:32 INFO - PROCESS | 1680 | __start_cc_report 22:07:32 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,1209 22:07:32 INFO - PROCESS | 1680 | __end_cc_report 22:07:32 INFO - PROCESS | 1680 | __startTimestamp1464239252845__endTimestamp 22:07:32 INFO - PROCESS | 1680 | 22:07:32 INFO - PROCESS | 1680 | ------- Summary: start ------- 22:07:32 INFO - PROCESS | 1680 | Number of tests: 14 22:07:32 INFO - PROCESS | 1680 | 22:07:32 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:112.60 Median:111.50 stddev:5.48 (4.9%) stddev-sans-first:5.73 22:07:32 INFO - PROCESS | 1680 | Values: 110.0 111.0 110.0 112.0 112.0 112.0 128.0 110.0 110.0 111.0 22:07:32 INFO - PROCESS | 1680 | 22:07:32 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:153.50 stddev:21.51 (14.0%) stddev-sans-first:19.03 22:07:32 INFO - PROCESS | 1680 | Values: 181.0 159.0 173.0 154.0 127.0 139.0 121.0 153.0 149.0 116.0 22:07:32 INFO - PROCESS | 1680 | 22:07:32 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:184.20 Median:184.00 stddev:2.25 (1.2%) stddev-sans-first:2.35 22:07:32 INFO - PROCESS | 1680 | Values: 183.0 184.0 185.0 184.0 185.0 182.0 183.0 183.0 190.0 183.0 22:07:32 INFO - PROCESS | 1680 | 22:07:32 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:73.90 Median:58.50 stddev:23.70 (40.5%) stddev-sans-first:25.09 22:07:32 INFO - PROCESS | 1680 | Values: 70.0 75.0 75.0 115.0 55.0 59.0 57.0 57.0 118.0 58.0 22:07:32 INFO - PROCESS | 1680 | 22:07:32 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:79.50 stddev:20.26 (25.5%) stddev-sans-first:21.33 22:07:32 INFO - PROCESS | 1680 | Values: 87.0 92.0 130.0 78.0 80.0 82.0 119.0 76.0 79.0 118.0 22:07:32 INFO - PROCESS | 1680 | 22:07:32 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:84.30 Median:85.50 stddev:1.89 (2.2%) stddev-sans-first:1.90 22:07:32 INFO - PROCESS | 1680 | Values: 86.0 83.0 87.0 82.0 86.0 83.0 85.0 83.0 86.0 82.0 22:07:32 INFO - PROCESS | 1680 | 22:07:32 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:95.70 Median:92.00 stddev:9.60 (10.4%) stddev-sans-first:10.09 22:07:32 INFO - PROCESS | 1680 | Values: 92.0 92.0 93.0 92.0 92.0 91.0 92.0 100.0 122.0 91.0 22:07:32 INFO - PROCESS | 1680 | 22:07:32 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:89.30 Median:85.00 stddev:11.44 (13.5%) stddev-sans-first:11.58 22:07:32 INFO - PROCESS | 1680 | Values: 99.0 119.0 83.0 85.0 84.0 85.0 86.0 83.0 85.0 84.0 22:07:32 INFO - PROCESS | 1680 | 22:07:32 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:56.00 stddev:3.81 (6.8%) stddev-sans-first:4.03 22:07:32 INFO - PROCESS | 1680 | Values: 56.0 57.0 56.0 56.0 57.0 56.0 56.0 56.0 67.0 52.0 22:07:32 INFO - PROCESS | 1680 | 22:07:32 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:65.50 stddev:2.88 (4.4%) stddev-sans-first:2.83 22:07:32 INFO - PROCESS | 1680 | Values: 63.0 70.0 63.0 71.0 69.0 66.0 64.0 65.0 65.0 65.0 22:07:32 INFO - PROCESS | 1680 | 22:07:32 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:80.50 stddev:10.01 (12.4%) stddev-sans-first:10.62 22:07:32 INFO - PROCESS | 1680 | Values: 83.0 80.0 81.0 80.0 81.0 82.0 101.0 67.0 80.0 100.0 22:07:32 INFO - PROCESS | 1680 | 22:07:32 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:131.00 stddev:9.24 (7.1%) stddev-sans-first:9.68 22:07:32 INFO - PROCESS | 1680 | Values: 120.0 131.0 132.0 118.0 118.0 110.0 135.0 131.0 133.0 113.0 22:07:32 INFO - PROCESS | 1680 | 22:07:32 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:129.50 Median:132.00 stddev:5.80 (4.4%) stddev-sans-first:6.12 22:07:32 INFO - PROCESS | 1680 | Values: 131.0 129.0 132.0 117.0 132.0 121.0 134.0 132.0 134.0 133.0 22:07:32 INFO - PROCESS | 1680 | 22:07:32 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.80 Median:73.50 stddev:13.25 (18.0%) stddev-sans-first:13.46 22:07:32 INFO - PROCESS | 1680 | Values: 65.0 68.0 73.0 96.0 92.0 95.0 74.0 64.0 66.0 65.0 22:07:32 INFO - PROCESS | 1680 | -------- Summary: end -------- 22:07:32 INFO - PROCESS | 1680 | 22:07:33 INFO - TEST-INFO | 1680: exit 0 22:07:33 INFO - TEST-OK | kraken | took 55912ms 22:07:33 INFO - SUITE-END | took 1168s 22:07:34 INFO - Completed test suite (00:19:28) 22:07:34 INFO - javascript benchmark 22:07:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3520.4895290182926, 3587.587427445841, 3587.587427445843, 3619.692326152276, 3664.157243833918, 5696.231008813809, 5733.111367737997, 5747.281589801275, 5769.192313076167, 5803.419658034194, 4661.0, 5775.2203452533895, 5779.450952159538, 5780.104083866997, 5781.653100813955, 5172.250023746555, 5188.37739471264, 5219.765110570014, 5236.607254455912, 5265.76304066318, 5288.444713305105, 5311.415744268127, 5319.9202011969855, 5324.0, 5327.413984461726, 5189.3772747270195, 5251.632385733, 5275.60432967529, 5293.258943747878, 5295.973520132394, 4719.528047195287, 5298.4966428189455, 5331.200319952039, 5350.5184533392185, 5357.8392648220615, 5152.227165925104, 5261.105612045962, 5274.5780337572905, 5295.629305948585, 5316.680999140064, 5678.630888992244, 5684.8294551163535, 5696.946064977951, 5698.886022279531, 5748.223989761413, 5123.385193776733, 6165.383461653843, 6268.843278918018, 6306.400891915307, 6320.178376810985, 6236.750529978795, 6249.12512248281, 6251.343608921089, 6255.999040153553, 6265.780697675559, 5969.820905372846, 5993.190919225936, 6000.129981152709, 6000.6399616022745, 6007.879842403127, 6191.349908259658, 6243.656598887105, 6302.275238347557, 6314.084457753692, 6339.0808332791485, 6236.844078898064, 6252.562320637512, 6257.405546473078, 6275.309715931244, 6276.340984196685, 6290.056491526308, 6292.590981586182, 6292.874142517124, 6303.212098487689, 6340.239171299474, 6108.633481991094, 6233.3143354231, 6240.282367527792, 6244.219472565929, 6249.6562689051625, 6197.318294987548, 6244.656543890039, 6267.6866156692895, 6275.121482992385, 6323.336049714806, 5004.2493625956395, 5005.424376196711, 5012.072766538202, 5015.974920125376, 5028.698278103326, 4431.357453169272, 4490.16931867599, 4495.078508905732, 4530.818767249273, 4544.7727613619845, 5938.6436813791315, 5992.221011268507, 5994.280686317583, 6033.336333003366, 6045.486133678599, 6229.56393052482, 6235.501159907287, 6251.9687401562705, 6267.592606480655, 6271.3728627136925, 5784.4504772046585, 5820.650760954356, 5971.2834459864225, 5972.761089556369, 6003.8198854034445, 5404.189371594213, 5452.509274165344, 5469.863253418617, 5480.150576660624, 5499.1476321170285, 6311.400416960381, 6330.556861019684, 6331.873362532631, 6334.651594162366, 6339.619622822645, 6167.105769663463, 6196.411340922605, 6279.434850863261, 6289.9056514153235, 6314.8737025258315, 6381.329960354282, 6421.678916054085, 6425.967870160619, 6426.550141490238, 6445.2587952386075, 6204.100405441095, 6256.906146407899, 6275.278342990615, 6279.246490421178, 6282.465990390868, 6156.384361563987, 6189.81430557084, 6213.2233470816145, 6271.372862713874, 6276.215473065867, 6009.849753756191, 6195.504359651307, 6198.752049918133, 6219.782307619212, 6233.657148856856, 6209.379062093754, 6210.130581718473, 6214.378562143749, 6223.751049957951, 6231.626102433868, 5960.791372301948, 6004.609700369462, 6074.1799857020505, 6118.710550942845, 6130.754769809158, 6155.815325540241, 6198.132261483306, 6198.845028874314, 6201.069839524108, 6236.875262494634, 6073.331933487401, 6107.69461526913, 6111.633302001894, 6112.510999120149, 6120.204373431426], "unit": "score", "name": "dojo.html", "value": 5775.524416599869}, {"lowerIsBetter": false, "replicates": [484.38966901703884, 584.4068270705233, 590.2238556298468, 667.9966600166998, 670.885949388604, 31786.523202151988, 40534.797326013366, 40575.391369129415, 40592.39111413327, 40661.0, 35600.0, 43449.0, 43966.56033439664, 44080.338794918025, 44112.0, 9828.901710982871, 10052.195824334036, 10069.798604027916, 10094.9495252524, 10119.645812396568, 9868.45723485208, 10005.849912251322, 10010.849837252446, 10012.69961901144, 10013.04876036779, 9962.701118966443, 10147.340422872527, 10162.187025038016, 10172.0, 10181.440020798853, 10070.1440377568, 10133.543990520371, 10156.593736250541, 10169.440680762555, 10175.491225438773, 9960.452175130366, 10084.596616135346, 10087.445190514518, 10102.747431314203, 10108.595656173744, 42416.787916060224, 42948.0, 42966.35550466745, 43090.35364469535, 43141.56858431407, 3258.7067163955358, 3340.515625234327, 3344.8494817733263, 3384.120128766514, 3435.278591495789, 28728.42543149146, 29061.85469072641, 29125.56311655327, 29194.854025729946, 30147.849260753555, 2594.9870250648814, 2800.2439341377917, 2832.362718388346, 2835.900743473989, 2935.1341354300534, 497603.0, 500174.0, 501495.0, 501898.0, 502127.0, 46980.7650961743, 47831.04337913222, 65417.345826541125, 66750.66624666845, 67036.32963670399, 46488.83777905579, 46666.0, 46673.29990050152, 46690.0, 46750.766246168554, 17537.824621753618, 17711.822881771273, 17711.911440442716, 17715.468535943943, 17719.29122835098, 14183.574492765234, 14262.286885655676, 14268.928655356656, 14273.85726142746, 14276.21480818565, 15242.390304387922, 15267.541973740805, 15284.388624454898, 15316.463923762614, 15405.691886162214, 6337.084940927133, 6474.773382931575, 6502.479801615859, 6506.446952009038, 6519.902201466982, 974.3471873844542, 1008.0826447932493, 1025.7538190834296, 1130.7371555480797, 1178.3695722788439, 30209.942652007074, 30218.84890575533, 30772.230694232825, 30826.69173308283, 30845.0, 942.0532364973158, 1095.3318475729798, 1131.3042478875598, 1216.391804097951, 1256.7298030923396, 15395.384184632489, 15446.0, 15485.612859678598, 15487.845121548866, 15827.446039388566, 533598.0, 539494.0, 541004.0, 548181.0, 548713.0, 59843.803123938145, 60216.397836021955, 60472.39527604756, 60513.09230361548, 60693.08960365598, 1401.3133564553295, 1502.9098254104788, 1507.3593722667822, 1522.6117340078208, 1531.992340038315, 25271.512322386003, 28992.855035724686, 29063.0, 30497.23756906095, 31049.68950310468, 48600.5139948596, 48641.75679121723, 49202.753986229836, 49208.01583968372, 49324.506754931994, 366897.1655141814, 367872.0, 368432.3156768398, 370031.0, 370175.0, 30082.0, 34361.140971475914, 34838.82580587081, 34959.65040349564, 35341.586336547276, 41894.790526047174, 43329.783351083046, 43444.782776085915, 43529.78235108804, 44241.55758442375, 34433.31133377369, 35737.64262357447, 35811.64188358083, 36042.8197859009, 36354.45468317925, 36940.076498087765, 37103.81448092742, 37318.81340593279, 37516.62483375131, 37526.81236593799, 29448.263793405335, 36832.63167368292, 37422.25155496929, 37451.625483744814, 37834.81082594569, 31123.84438077795, 32447.0, 32749.69001239924, 32840.014799556055, 32997.50503742494, 19727.605447890674, 23409.829508524166, 23601.0559577615, 23829.880850595637, 24041.398965025313], "unit": "score", "name": "ext.html", "value": 19567.077317823172}, {"lowerIsBetter": false, "replicates": [388.81336958260033, 392.95088113985753, 393.58869980869986, 402.2337447163155, 403.2580052703026, 20220.89889550552, 21766.238181663644, 21885.0, 22163.0, 22228.333150005485, 21695.132194712194, 21801.0, 22404.439889002784, 22434.551308973852, 22666.66000010001, 5935.792247271346, 5997.6701281429505, 6174.660393678346, 6185.103160041791, 6217.285012223607, 6107.541934354919, 6154.0, 6173.475254603341, 6174.135621013062, 6178.938210617904, 5856.824295271149, 6045.093236014589, 6071.3625069367745, 6120.051392034219, 6124.418180272867, 5909.793157239476, 6040.697965101749, 6070.271567411917, 6073.423024812636, 6111.327753947062, 5714.599978001542, 5750.45370689788, 5754.654720716729, 5843.094320380348, 5860.267466566679, 13902.374393152231, 14038.508652197124, 14247.572572822832, 16030.0, 22764.658530121895, 2310.676505289261, 2317.5480781247666, 2324.1865347128537, 2348.178137651825, 2377.037299893546, 9988.05113514215, 10112.191024718006, 10566.260361774679, 13224.6693832654, 14712.55862324132, 1702.8978261304362, 1722.1389305347327, 1724.1896308734874, 1732.7314266288745, 1738.6522695460833, 103011.96988030174, 103490.96509034888, 105895.47052264767, 106218.0, 106424.0, 11435.542578296941, 11500.884991149982, 11589.99999999983, 11592.88407115918, 11732.530698772125, 11766.705832354259, 14346.713065738626, 14377.137371757728, 14387.78418323726, 14389.856101439062, 8764.123587641185, 8927.419717718327, 8936.776580585407, 9037.683681071263, 9044.954775226082, 9205.677801276923, 9208.63165473387, 9243.90756092444, 9275.072492750805, 9312.161905428544, 3599.7300202484917, 4409.2724700424715, 4491.752953587584, 4528.45658520973, 4617.307403889444, 1872.2587993166214, 1924.0, 1927.354336297328, 1955.1104247567323, 1977.9714548434733, 739.7780665800238, 814.3647954595425, 832.650286879512, 900.8063266397756, 952.538019060755, 20048.69926951097, 20783.584328313653, 21004.65292944625, 21510.784892150878, 21848.01683924227, 955.6129767444196, 1001.2540657210425, 1017.2624846986024, 1058.655936820521, 1069.903708666208, 10974.506147223394, 11415.315081095161, 11427.971482566443, 11452.885471145182, 11468.4839182237, 283150.0, 648903.0, 651591.0, 663791.0, 682896.0, 101295.49352253339, 113017.43491282492, 117696.41151794358, 128871.35564322305, 131058.0, 1070.4273213830718, 1083.5124194112682, 1099.054812860923, 1100.5542755184163, 1105.1379923659558, 18600.813991859908, 19032.858028518334, 19288.90355548213, 19342.516437089187, 19627.11677974466, 37181.25637487289, 53584.732076339365, 54200.91598168093, 54295.82816687288, 54755.452445475035, 61078.38921610905, 70897.6455117721, 77241.0, 79575.20424795678, 80369.1963080385, 7877.842443151219, 8050.235227653364, 8294.087650358577, 8316.542590157358, 8497.787555311166, 10047.899521004696, 13445.529406470727, 13729.45082196701, 13817.516386926409, 13859.307034648025, 11715.531378744754, 11757.529698811952, 11802.76394472123, 11846.585369512026, 12151.878481215075, 11610.0, 11680.240784348991, 11701.0, 11945.581904633296, 12130.454129564367, 6198.845028874314, 10859.457027148768, 11013.449327533752, 11631.011364034151, 12034.518619255132, 8359.707410240855, 8367.121452247426, 8498.61756220984, 8563.400561960603, 8781.253593444373, 11663.300201987568, 11897.0, 11898.821517677416, 12079.214851034654, 12090.697732556757], "unit": "score", "name": "jquery.html", "value": 9609.918321235553}, {"lowerIsBetter": false, "replicates": [1484.5768955847586, 1603.863671587915, 1610.7342288522395, 1928.5853541488577, 2073.5023594337354, 8265.380096492765, 8818.07410221927, 8978.102189781019, 8988.820223595541, 9000.549972501381, 8476.15238476152, 8694.782630434242, 8695.56522173892, 8709.388763078834, 8739.86890196646, 2535.2267558394683, 2536.6702328697243, 2536.8604726740023, 2538.4796116796015, 2581.90963316284, 2460.766227208412, 2545.7963362930923, 2547.8726063696836, 2550.41340491687, 2556.5526032944254, 2515.8490490570534, 2532.708738495069, 2534.911278105267, 2535.936601584966, 2538.530371881199, 2078.688196770481, 2485.72657007729, 2504.7119581248207, 2507.4859653771023, 2532.113760183939, 2517.1819158773474, 2525.5454018276705, 2525.911593094251, 2525.9747402525923, 2532.683414573178, 8849.646014159425, 8887.466751994836, 8890.955545222298, 8891.911080889238, 8910.242629376511, 5583.8883222335735, 5707.6290041147195, 5746.281714785652, 5749.540036797046, 5759.913601295984, 3654.903528941307, 3731.3470142724914, 3790.5451345838674, 3795.6394142556414, 3803.7147213959065, 1062.219268837404, 1077.4343469678404, 1077.8491011258352, 1087.613897066538, 1112.1380929779405, 12286.508539658404, 12310.015198784076, 12315.014798816073, 12348.073894457862, 12353.62939111828, 4874.2201247800185, 4920.901581968341, 4951.430585482643, 4996.7001979881325, 5013.824516141991, 10415.854256031831, 10417.843732344021, 10422.895771042193, 10427.739306517245, 10432.0, 5645.491905728504, 5685.346185188756, 5695.373508914016, 5702.173184888168, 5779.393163717833, 4537.500874903758, 4711.811527538928, 4911.287863259808, 5102.158143906288, 5155.123628983082, 3974.125692347679, 4026.6778657707314, 4030.1738143680477, 4065.7560546367313, 4087.89780255496, 1345.4954392102961, 1356.0914187494402, 1366.794980752895, 1373.9763875912508, 1379.6206043338161, 1417.8085958395484, 1431.8639729225706, 1456.4829485532696, 1457.8615031571983, 1463.8462961389114, 8405.579721014046, 8503.362247831437, 8505.192006759347, 8522.275606573387, 8557.400981931205, 464.59348070438364, 521.9045532188267, 527.3803281144716, 534.834201397568, 541.3963430774658, 6298.968505157445, 6310.8422289442215, 6350.491960643138, 6352.904706429407, 6356.4279214870885, 10735.89264107349, 11197.832032519518, 11241.775164496665, 11257.324560526395, 11289.548418063185, 10623.36259824413, 10953.945230273797, 10992.560297588167, 11044.558217671203, 11090.722731931766, 8515.19105684959, 8528.701495447629, 8587.871181932276, 8589.914100859036, 8613.310935125175, 7934.960325198337, 8064.758057258292, 8083.312918402002, 8089.069756978023, 8157.584734599931, 9604.991475895209, 9790.804183916423, 9885.851712224467, 10011.349262297927, 10012.59949602037, 9887.604495820087, 10217.795644087226, 10296.948515257376, 10299.97000299964, 10410.583576657153, 7597.012388389474, 7608.695652173851, 7618.314351708373, 7667.079950405987, 7668.309852113337, 8300.709475168582, 8352.958235208785, 8397.328213742763, 8411.8738218928, 8413.158684131538, 7471.290227428385, 7580.128285247267, 7632.580208088609, 7730.497517661334, 7751.186125456746, 7356.448266379936, 7431.665575049244, 7447.478676492594, 7549.7357592483995, 7549.811254718676, 6527.477801775942, 7659.851022346693, 7669.1947345527915, 7700.422468314787, 7752.573608451364, 6891.207511136284, 7101.11236095488, 7129.25142860013, 7159.0, 7188.676509557187, 7236.855262894818, 7252.782416527512, 7273.3817625500305, 7277.454190935595, 7279.890801638086], "unit": "score", "name": "mootools.html", "value": 4982.684509741185}, {"lowerIsBetter": false, "replicates": [337.31188375713543, 339.6620362739075, 345.82190172061394, 349.41647448760574, 354.2419222863072, 6279.0, 6758.256591774901, 6784.253732089466, 6817.181938167427, 6822.215445223795, 5797.391273916231, 6372.821028109803, 6717.126773519436, 6785.796426107212, 6799.354061364174, 4839.177339852216, 4925.950740492585, 4997.450280469146, 5041.8235361762345, 5088.287639730432, 4142.647874930634, 4836.645739193032, 5017.824376146836, 5036.370453693288, 5045.268436076767, 4373.540778218289, 5025.04524140414, 5043.722595257259, 5048.6465947383695, 5054.646174767768, 4812.855614331575, 4890.193118135503, 4987.850364489072, 5000.549950504472, 5003.099442100421, 4317.9421041844635, 4337.891552711208, 4338.891527711801, 4366.956330436687, 4372.519022907478, 6519.8044058678315, 6520.706568204442, 6522.445592124675, 6524.249711283168, 6557.2131344239, 5974.880502389971, 5977.073553599199, 5978.940210597882, 5986.281646202484, 5989.2812862456785, 6954.582725036514, 7243.275672432767, 7243.311885370934, 7247.818804529877, 7269.382102521292, 4818.951810481885, 4869.63477739171, 4871.098846713369, 4871.318015477836, 4884.926726099111, 7591.3926885849, 7660.2722741339485, 7664.271894170045, 7672.46292759507, 7674.1942096079665, 4972.90054198914, 4987.351644286219, 4991.775370108281, 4995.700257984533, 5006.098902197639, 4137.482814648169, 5041.747912604355, 5042.621803364762, 5051.797928082909, 5053.747312634354, 5787.971060144672, 5904.439078287556, 5964.075568286922, 5964.433378829004, 5983.850403739942, 7191.3887319578425, 7257.49197556166, 7268.636568171676, 7284.380827629605, 7296.744613938593, 1739.9130043497773, 1760.3662681434673, 1765.2762367429293, 1766.0110338210643, 1768.6727955328306, 1063.872335319751, 1119.8712148103073, 1122.421952694363, 1132.6771870017005, 1158.8609366876028, 6294.622322660655, 6850.040994260808, 6870.793876183722, 6891.448684105259, 6919.273476284918, 7426.814329641694, 7434.881058898296, 7443.739469118555, 7452.292032256927, 7472.215417381205, 6852.931470685229, 6856.314368563104, 6862.416694580917, 6862.656867156622, 6881.380675739108, 3855.9036024099623, 3923.7645741255615, 3960.6435420812263, 3967.3850553164307, 3973.5033120859894, 7859.449838511249, 7861.0, 7901.0, 7906.0, 7933.127355990837, 7760.029996250469, 7768.961155194301, 7771.961140194263, 7789.792582149776, 7800.9219907801335, 7897.644605992629, 7916.089649690244, 7924.48490848093, 7926.405519585939, 7931.841363172589, 6131.724072416663, 7287.817804554928, 7354.117505899327, 7538.208488108889, 7560.470767046254, 7403.629818509161, 7419.07261592301, 7427.22014188524, 7454.962725186339, 7469.327760501581, 6866.4506839453725, 7894.565798880887, 7895.565743884142, 7927.484713493604, 7948.761537153895, 3940.527136743609, 4732.20799728162, 4775.092732380836, 4786.44955830084, 4789.928151077806, 7240.637968101469, 7510.8497830042, 7521.05986751656, 7534.510256833289, 7541.660625271767, 7245.5652660840515, 7273.599952002479, 7298.197198308288, 7305.452091093083, 7309.744158954411, 5785.652860828363, 7276.163241227115, 7276.527025743309, 7282.563046217244, 7287.635618219174, 6547.6577301654, 6680.365365290289, 7100.680469378787, 7133.144022717307, 7165.713371465083, 5879.676617786063, 7034.788956331318, 7289.744858929912, 7308.269173082649, 7309.049823523121, 6861.245263020964, 7071.0, 7079.646017699198, 7080.504364694628, 7111.431085513043], "unit": "score", "name": "prototype.html", "value": 5315.969388621125}, {"lowerIsBetter": false, "replicates": [719.780466957578, 735.2830989784957, 751.6282783919348, 795.9164287749785, 827.5407149032288, 15164.924175379121, 15211.23943802811, 15444.0, 15477.148756818384, 15479.690406191869, 14052.227127507984, 14130.152190868555, 14143.646408839784, 14144.646383840409, 14147.0, 821.40858581821, 832.9750107496754, 955.8948515663288, 958.1999030809283, 994.9950549944535, 976.3458482816494, 976.7802244494967, 978.4325091446943, 981.6269817469351, 982.1013772398247, 1051.8474821150928, 1055.0082922053284, 1057.6562617149418, 1058.0794708603526, 1061.4533515239618, 856.3620103023256, 894.6019021535419, 1042.781015986636, 1046.6650671785033, 1047.1988928469727, 774.3263360876017, 774.4849674966141, 775.678093591159, 776.5534817479916, 777.8016605765494, 15301.846981530265, 15326.540203793904, 15347.0, 15351.616209594738, 15360.846391536053, 12932.741345173044, 12987.480500779957, 13213.207207567577, 13237.470501179941, 13382.598522044354, 10294.073533382032, 10330.380177189392, 10470.738231544196, 10658.094062004739, 10962.232643714942, 3530.188056746937, 3576.4635304704243, 3616.8191590420374, 3647.9817600911824, 3666.32173047987, 82326.0, 82700.58649706712, 83103.5844820778, 83694.0, 86765.69851452233, 9669.323147379617, 9724.513774311397, 9854.310198286052, 9858.211343092678, 9861.950690246504, 21942.89028554847, 22237.888810555844, 22273.888630556743, 22283.0, 22572.0971161155, 7816.101148367897, 7973.960130199312, 7990.840183196304, 8159.67361305553, 8196.67213311461, 4242.745435273893, 4270.35944608305, 4296.419983302277, 4408.889777755582, 4617.422822147231, 3707.8516859325323, 3766.246750649881, 3768.8680896168503, 3769.2273084018257, 3770.208256266215, 621.1087090025827, 631.7125707802938, 643.7392855893277, 655.790147152916, 662.211967758366, 598.9940100599025, 608.9604175728564, 617.8733359661348, 626.3235705438207, 628.8773689130576, 8437.520227443585, 8628.956855215683, 8657.783555411164, 8665.523396213268, 8724.214820666044, 560.5095541401274, 599.7001499250375, 604.9969750151221, 618.9102580125947, 631.3024108360288, 2898.3623602807347, 3902.551206611276, 4053.2298863215897, 4131.586841315904, 4182.832686692559, 93886.0, 95154.52422737842, 97134.51432742791, 97447.0, 97626.02373976169, 78735.85056597786, 80779.59610201912, 80930.78603820948, 81833.59083204666, 82433.17566824376, 69702.65148674224, 70234.64882675656, 71431.6428417865, 71446.285537145, 72358.27641723516, 7763.2236776321915, 7847.176046515034, 7855.332296754611, 8104.878426823484, 8123.71566995176, 51232.0, 51448.48551514437, 51673.48326516837, 51885.62743421666, 52968.73515632397, 68073.31926680669, 70390.64804676149, 70441.0, 70506.94239586308, 70997.15555466634, 11139.72150696239, 11141.888581114084, 11193.104551636012, 11347.20569560123, 11572.305661660328, 11827.645170644895, 12198.634040978784, 12416.849243092764, 12455.93772031134, 12550.560730374758, 11549.942250288696, 11733.647990560297, 11904.096462509026, 11950.581729639769, 12182.269063856196, 11662.825057623973, 11788.469518871843, 11917.40412979365, 12074.215176013531, 12242.510299587917, 11537.368003631089, 11541.0, 11712.765744685228, 11745.001674857733, 11924.940375298069, 9746.0, 9830.557624906753, 9873.25950553697, 9925.950370248103, 9937.701868943943, 9818.803623927624, 9826.312158149147, 9861.457619830979, 9923.35498192644, 10038.146757525692], "unit": "score", "name": "yui.html", "value": 7168.756321110081}], "name": "dromaeo_css", "value": 7686.464538641405}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 112.0, 112.0, 112.0, 128.0, 110.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.6}, {"lowerIsBetter": true, "replicates": [181.0, 159.0, 173.0, 154.0, 127.0, 139.0, 121.0, 153.0, 149.0, 116.0], "unit": "score", "name": "audio-beat-detection", "value": 147.2}, {"lowerIsBetter": true, "replicates": [183.0, 184.0, 185.0, 184.0, 185.0, 182.0, 183.0, 183.0, 190.0, 183.0], "unit": "score", "name": "audio-dft", "value": 184.2}, {"lowerIsBetter": true, "replicates": [70.0, 75.0, 75.0, 115.0, 55.0, 59.0, 57.0, 57.0, 118.0, 58.0], "unit": "score", "name": "audio-fft", "value": 73.9}, {"lowerIsBetter": true, "replicates": [87.0, 92.0, 130.0, 78.0, 80.0, 82.0, 119.0, 76.0, 79.0, 118.0], "unit": "score", "name": "audio-oscillator", "value": 94.1}, {"lowerIsBetter": true, "replicates": [86.0, 83.0, 87.0, 82.0, 86.0, 83.0, 85.0, 83.0, 86.0, 82.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 84.3}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 93.0, 92.0, 92.0, 91.0, 92.0, 100.0, 122.0, 91.0], "unit": "score", "name": "imaging-darkroom", "value": 95.7}, {"lowerIsBetter": true, "replicates": [99.0, 119.0, 83.0, 85.0, 84.0, 85.0, 86.0, 83.0, 85.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 89.3}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 56.0, 56.0, 57.0, 56.0, 56.0, 56.0, 67.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 56.9}, {"lowerIsBetter": true, "replicates": [63.0, 70.0, 63.0, 71.0, 69.0, 66.0, 64.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.1}, {"lowerIsBetter": true, "replicates": [83.0, 80.0, 81.0, 80.0, 81.0, 82.0, 101.0, 67.0, 80.0, 100.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.5}, {"lowerIsBetter": true, "replicates": [120.0, 131.0, 132.0, 118.0, 118.0, 110.0, 135.0, 131.0, 133.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.1}, {"lowerIsBetter": true, "replicates": [131.0, 129.0, 132.0, 117.0, 132.0, 121.0, 134.0, 132.0, 134.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 129.5}, {"lowerIsBetter": true, "replicates": [65.0, 68.0, 73.0, 96.0, 92.0, 95.0, 74.0, 64.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 75.8}], "name": "kraken", "value": 1417.1999999999998}]} 22:07:34 INFO - Return code: 0 22:07:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:07:34 INFO - # TBPL SUCCESS # 22:07:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:07:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:07:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:07:34 INFO - 2016-05-25 22:07:34.167 screenresolution[1684:10017] starting screenresolution argv=screenresolution get 22:07:34 INFO - 2016-05-25 22:07:34.170 screenresolution[1684:10017] Display 0: 1600x1200x32@60 22:07:34 INFO - 2016-05-25 22:07:34.176 screenresolution[1685:10020] starting screenresolution argv=screenresolution list 22:07:34 INFO - Available Modes on Display 0 22:07:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:07:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:07:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:07:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:07:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:07:34 INFO - Intel Iris: 22:07:34 INFO - Chipset Model: Intel Iris 22:07:34 INFO - Type: GPU 22:07:34 INFO - Bus: Built-In 22:07:34 INFO - VRAM (Dynamic, Max): 1536 MB 22:07:34 INFO - Vendor: Intel (0x8086) 22:07:34 INFO - Device ID: 0x0a2e 22:07:34 INFO - Revision ID: 0x0009 22:07:34 INFO - Displays: 22:07:34 INFO - Display: 22:07:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:07:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:07:34 INFO - Display Serial Number: 1600x1200 60 22:07:34 INFO - Main Display: Yes 22:07:34 INFO - Mirror: Off 22:07:34 INFO - Online: Yes 22:07:34 INFO - Rotation: Supported 22:07:34 INFO - Return code: 0 22:07:34 INFO - Running post-action listener: _resource_record_post_action 22:07:34 INFO - Running post-run listener: _resource_record_post_run 22:07:35 INFO - Total resource usage - Wall time: 1192s; CPU: 52.0%; Read bytes: 31514112; Write bytes: 508901888; Read time: 196; Write time: 1550 22:07:35 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 200788480; Write bytes: 198744064; Read time: 17991; Write time: 414 22:07:35 INFO - run-tests - Wall time: 1171s; CPU: 52.0%; Read bytes: 29732352; Write bytes: 299311616; Read time: 179; Write time: 1099 22:07:35 INFO - Running post-run listener: _upload_blobber_files 22:07:35 INFO - Blob upload gear active. 22:07:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:07:35 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 22:07:35 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'] 22:07:35 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 22:07:35 INFO - (blobuploader) - INFO - Open directory for files ... 22:07:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:07:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:07:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:07:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:07:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:07:37 INFO - (blobuploader) - INFO - Done attempting. 22:07:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:07:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:07:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:07:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:07:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:07:38 INFO - (blobuploader) - INFO - Done attempting. 22:07:38 INFO - (blobuploader) - INFO - Iteration through files over. 22:07:38 INFO - Return code: 0 22:07:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:07:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:07:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71c08950129e01f7ae4dc64de79836fe7446f634d31e20c18a2b52dd6d0578626973908186e441703d00083e6e5b909bf4c50c0c052894260cc2db8fc25d5b10", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/801cb0b9c919a7e27978e851ce041d9f1ce05482f3b498be835e33a60707b4efe8bb0eb7b8fca9917d24ce4a7b3e9de61ed60aea6ea4706300972e1812a49cca"} 22:07:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:07:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:07:38 INFO - Contents: 22:07:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71c08950129e01f7ae4dc64de79836fe7446f634d31e20c18a2b52dd6d0578626973908186e441703d00083e6e5b909bf4c50c0c052894260cc2db8fc25d5b10", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/801cb0b9c919a7e27978e851ce041d9f1ce05482f3b498be835e33a60707b4efe8bb0eb7b8fca9917d24ce4a7b3e9de61ed60aea6ea4706300972e1812a49cca"} 22:07:38 INFO - Running post-run listener: copy_logs_to_upload_dir 22:07:38 INFO - Copying logs to upload dir... 22:07:38 INFO - mkdir: /builds/slave/test/build/upload/logs 22:07:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.636001 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2016-05-25 22:07:38.144715) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 22:07:38.148753) ========= 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.nNCK4JoVpY/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.jBz3CFuQaD/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71c08950129e01f7ae4dc64de79836fe7446f634d31e20c18a2b52dd6d0578626973908186e441703d00083e6e5b909bf4c50c0c052894260cc2db8fc25d5b10", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/801cb0b9c919a7e27978e851ce041d9f1ce05482f3b498be835e33a60707b4efe8bb0eb7b8fca9917d24ce4a7b3e9de61ed60aea6ea4706300972e1812a49cca"} build_url:https://queue.taskcluster.net/v1/task/XsF9mbzDSWG9QyCzWKof2Q/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011063 build_url: 'https://queue.taskcluster.net/v1/task/XsF9mbzDSWG9QyCzWKof2Q/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71c08950129e01f7ae4dc64de79836fe7446f634d31e20c18a2b52dd6d0578626973908186e441703d00083e6e5b909bf4c50c0c052894260cc2db8fc25d5b10", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/801cb0b9c919a7e27978e851ce041d9f1ce05482f3b498be835e33a60707b4efe8bb0eb7b8fca9917d24ce4a7b3e9de61ed60aea6ea4706300972e1812a49cca"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 22:07:38.179555) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 22:07:38.179894) ========= 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.nNCK4JoVpY/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.jBz3CFuQaD/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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.004484 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 22:07:38.228446) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 22:07:38.228755) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 22:07:38.229127) ========= ========= Total master_lag: 0.21 =========