builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0105 starttime: 1467224112.41 results: success (0) buildid: 20160629085825 builduid: bb4f4bf648064d3f97eed48930c3c8a3 revision: a470d1809acea1d1b6139a962d137b436578317a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 11:15:12.406067) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 11:15:12.406470) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 11:15:12.406755) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 11:15:12.429559) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:15:12.429918) ========= 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.3Haw4K7foI/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.vZzXE4SEUQ/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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-06-29 11:15:12-- 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% 10.3M=0.001s 2016-06-29 11:15:12 (10.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.288467 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:15:12.740652) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:15:12.740969) ========= 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.3Haw4K7foI/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.vZzXE4SEUQ/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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.020479 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:15:12.790163) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-29 11:15:12.793522) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a470d1809acea1d1b6139a962d137b436578317a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev a470d1809acea1d1b6139a962d137b436578317a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3Haw4K7foI/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.vZzXE4SEUQ/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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-06-29 11:15:12,867 truncating revision to first 12 chars 2016-06-29 11:15:12,867 Setting DEBUG logging. 2016-06-29 11:15:12,867 attempt 1/10 2016-06-29 11:15:12,867 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a470d1809ace?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 11:15:13,598 unpacking tar archive at: fx-team-a470d1809ace/testing/mozharness/ program finished with exit code 0 elapsedTime=1.007808 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-29 11:15:13.828242) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 11:15:13.828595) ========= script_repo_revision: a470d1809acea1d1b6139a962d137b436578317a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 11:15:13.829006) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 11:15:13.829303) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 11:15:13.847428) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-06-29 11:15:13.847828) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3Haw4K7foI/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.vZzXE4SEUQ/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 11:15:14 INFO - MultiFileLogger online at 20160629 11:15:14 in /builds/slave/test 11:15:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:15:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:15:14 INFO - {'append_to_log': False, 11:15:14 INFO - 'base_work_dir': '/builds/slave/test', 11:15:14 INFO - 'blob_upload_branch': 'Fx-Team', 11:15:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:15:14 INFO - 'branch': 'Fx-Team', 11:15:14 INFO - 'buildbot_json_path': 'buildprops.json', 11:15:14 INFO - 'config_files': ('talos/mac_config.py',), 11:15:14 INFO - 'default_actions': ('clobber', 11:15:14 INFO - 'read-buildbot-config', 11:15:14 INFO - 'download-and-extract', 11:15:14 INFO - 'populate-webroot', 11:15:14 INFO - 'create-virtualenv', 11:15:14 INFO - 'install', 11:15:14 INFO - 'run-tests'), 11:15:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:15:14 INFO - 'download_minidump_stackwalk': True, 11:15:14 INFO - 'download_symbols': 'ondemand', 11:15:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:15:14 INFO - 'tooltool.py': '/tools/tooltool.py', 11:15:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:15:14 INFO - '/tools/misc-python/virtualenv.py')}, 11:15:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:15:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:15:14 INFO - 'installer_path': 'installer.exe', 11:15:14 INFO - 'log_level': 'info', 11:15:14 INFO - 'log_name': 'talos', 11:15:14 INFO - 'log_to_console': True, 11:15:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:15:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:15:14 INFO - 'opt_config_files': (), 11:15:14 INFO - 'pip_index': False, 11:15:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:15:14 INFO - 'cmd': ('bash', 11:15:14 INFO - '-c', 11:15:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:15:14 INFO - 'enabled': True, 11:15:14 INFO - 'halt_on_failure': False, 11:15:14 INFO - 'name': 'check_screen_resolution'},), 11:15:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:15:14 INFO - 'cmd': ('bash', 11:15:14 INFO - '-c', 11:15:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:15:14 INFO - 'enabled': True, 11:15:14 INFO - 'halt_on_failure': False, 11:15:14 INFO - 'name': 'check_screen_resolution'},), 11:15:14 INFO - 'run_cmd_checks_enabled': True, 11:15:14 INFO - 'sps_profile': False, 11:15:14 INFO - 'sps_profile_interval': 0, 11:15:14 INFO - 'suite': 'dromaeojs', 11:15:14 INFO - 'system_bits': '32', 11:15:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:15:14 INFO - 'title': 't-yosemite-r7-0105', 11:15:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:15:14 INFO - 'use_talos_json': True, 11:15:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:15:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:15:14 INFO - 'work_dir': 'build'} 11:15:14 INFO - ##### 11:15:14 INFO - ##### Running clobber step. 11:15:14 INFO - ##### 11:15:14 INFO - Running pre-action listener: _resource_record_pre_action 11:15:14 INFO - Running main action method: clobber 11:15:14 INFO - rmtree: /builds/slave/test/build 11:15:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:15:15 INFO - Running post-action listener: _resource_record_post_action 11:15:15 INFO - ##### 11:15:15 INFO - ##### Finished clobber step (success) 11:15:15 INFO - ##### 11:15:15 INFO - ##### 11:15:15 INFO - ##### Running read-buildbot-config step. 11:15:15 INFO - ##### 11:15:15 INFO - Running pre-action listener: _resource_record_pre_action 11:15:15 INFO - Running main action method: read_buildbot_config 11:15:15 INFO - Using buildbot properties: 11:15:15 INFO - { 11:15:15 INFO - "project": "", 11:15:15 INFO - "product": "firefox", 11:15:15 INFO - "script_repo_revision": "production", 11:15:15 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 11:15:15 INFO - "repository": "", 11:15:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 11:15:15 INFO - "buildid": "20160629085825", 11:15:15 INFO - "pgo_build": "False", 11:15:15 INFO - "basedir": "/builds/slave/test", 11:15:15 INFO - "buildnumber": 69, 11:15:15 INFO - "slavename": "t-yosemite-r7-0105", 11:15:15 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 11:15:15 INFO - "platform": "yosemite_r7", 11:15:15 INFO - "scheduler": "tests-fx-team-macosx64-talos", 11:15:15 INFO - "branch": "fx-team", 11:15:15 INFO - "repo_path": "integration/fx-team", 11:15:15 INFO - "revision": "a470d1809acea1d1b6139a962d137b436578317a", 11:15:15 INFO - "stage_platform": "macosx64", 11:15:15 INFO - "builduid": "bb4f4bf648064d3f97eed48930c3c8a3", 11:15:15 INFO - "slavebuilddir": "test" 11:15:15 INFO - } 11:15:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 11:15:15 INFO - Running post-action listener: _resource_record_post_action 11:15:15 INFO - ##### 11:15:15 INFO - ##### Finished read-buildbot-config step (success) 11:15:15 INFO - ##### 11:15:15 INFO - ##### 11:15:15 INFO - ##### Running download-and-extract step. 11:15:15 INFO - ##### 11:15:15 INFO - Running pre-action listener: _resource_record_pre_action 11:15:15 INFO - Running main action method: download_and_extract 11:15:15 INFO - mkdir: /builds/slave/test/build/tests 11:15: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')]} 11:15:15 INFO - https://queue.taskcluster.net/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:15:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 11:15:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 11:15:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 11:15:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 11:15:16 INFO - Downloaded 1199 bytes. 11:15:16 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 11:15:16 INFO - Using the following test package requirements: 11:15:16 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 11:15:16 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:15:16 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 11:15:16 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:15:16 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 11:15:16 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:15:16 INFO - u'jsshell-mac.zip'], 11:15:16 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:15:16 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 11:15:16 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 11:15:16 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:15:16 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 11:15:16 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:15:16 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 11:15:16 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:15:16 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 11:15:16 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:15:16 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 11:15:16 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:16 INFO - https://queue.taskcluster.net/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:15:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 11:15:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 11:15:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 11:15:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:15:19 INFO - Downloaded 18788521 bytes. 11:15:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:15:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:15:22 INFO - Return code: 0 11:15:22 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:15:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:22 INFO - https://queue.taskcluster.net/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:15:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 11:15:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 11:15:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 11:15:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:15:23 INFO - Downloaded 18788521 bytes. 11:15:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:15:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:15:27 INFO - Return code: 0 11:15: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')]} 11:15:27 INFO - https://queue.taskcluster.net/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:15:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 11:15:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 11:15:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 11:15:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:15:28 INFO - Downloaded 14405245 bytes. 11:15:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:15:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 11:15:28 INFO - Return code: 0 11:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:28 INFO - https://queue.taskcluster.net/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:15:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 11:15:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 11:15:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 11:15:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 11:15:33 INFO - Downloaded 112476862 bytes. 11:15:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 11:15:33 INFO - mkdir: /builds/slave/test/properties 11:15:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:15:33 INFO - Writing to file /builds/slave/test/properties/build_url 11:15:33 INFO - Contents: 11:15:33 INFO - build_url:https://queue.taskcluster.net/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 11:15:34 INFO - Running post-action listener: _resource_record_post_action 11:15:34 INFO - Running post-action listener: set_extra_try_arguments 11:15:34 INFO - ##### 11:15:34 INFO - ##### Finished download-and-extract step (success) 11:15:34 INFO - ##### 11:15:34 INFO - ##### 11:15:34 INFO - ##### Running populate-webroot step. 11:15:34 INFO - ##### 11:15:34 INFO - Running pre-action listener: _resource_record_pre_action 11:15:34 INFO - Running main action method: populate_webroot 11:15:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:15:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:15:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:15:34 INFO - '--tppagecycles', 11:15:34 INFO - '7'], 11:15:34 INFO - 'tests': ['tsvgm']}}, 11:15:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:15:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:15:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:15:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:15:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:15:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:15:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:34 INFO - 'talos_options': ['--disable-e10s'], 11:15:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:15:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:15:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:34 INFO - 'talos_options': ['--disable-e10s'], 11:15:34 INFO - 'tests': ['damp', 'tps']}, 11:15:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:34 INFO - 'tests': ['damp', 'tps']}, 11:15:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:15:34 INFO - 'tests': ['dromaeo_dom']}, 11:15:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:15:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:15:34 INFO - 'tests': ['basic_compositor_video']}, 11:15:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:15:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:15:34 INFO - 'tests': ['a11yr', 11:15:34 INFO - 'ts_paint', 11:15:34 INFO - 'tpaint', 11:15:34 INFO - 'sessionrestore', 11:15:34 INFO - 'sessionrestore_no_auto_restore', 11:15:34 INFO - 'tabpaint']}, 11:15:34 INFO - 'other-e10s': {'tests': ['a11yr', 11:15:34 INFO - 'ts_paint', 11:15:34 INFO - 'tpaint', 11:15:34 INFO - 'sessionrestore', 11:15:34 INFO - 'sessionrestore_no_auto_restore', 11:15:34 INFO - 'tabpaint']}, 11:15:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:15:34 INFO - 'ts_paint', 11:15:34 INFO - 'tpaint', 11:15:34 INFO - 'sessionrestore', 11:15:34 INFO - 'sessionrestore_no_auto_restore', 11:15:34 INFO - 'tabpaint']}, 11:15:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:15:34 INFO - 'ts_paint', 11:15:34 INFO - 'tpaint', 11:15:34 INFO - 'sessionrestore', 11:15:34 INFO - 'sessionrestore_no_auto_restore', 11:15:34 INFO - 'tabpaint']}, 11:15:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:15:34 INFO - 'tests': ['a11yr', 11:15:34 INFO - 'ts_paint', 11:15:34 INFO - 'tpaint', 11:15:34 INFO - 'sessionrestore', 11:15:34 INFO - 'sessionrestore_no_auto_restore', 11:15:34 INFO - 'tabpaint']}, 11:15:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:15:34 INFO - 'tests': ['a11yr', 11:15:34 INFO - 'ts_paint', 11:15:34 INFO - 'tpaint', 11:15:34 INFO - 'sessionrestore', 11:15:34 INFO - 'sessionrestore_no_auto_restore', 11:15:34 INFO - 'tabpaint']}, 11:15:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:15:34 INFO - 'tests': ['tsvgx', 11:15:34 INFO - 'tsvgr_opacity', 11:15:34 INFO - 'tart', 11:15:34 INFO - 'tscrollx', 11:15:34 INFO - 'cart']}, 11:15:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:15:34 INFO - 'tsvgr_opacity', 11:15:34 INFO - 'tart', 11:15:34 INFO - 'tscrollx', 11:15:34 INFO - 'cart']}, 11:15:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:34 INFO - 'talos_options': ['--disable-e10s'], 11:15:34 INFO - 'tests': ['tp5o']}, 11:15:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:34 INFO - 'tests': ['tp5o']}, 11:15:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:34 INFO - 'talos_options': ['--disable-e10s', 11:15:34 INFO - '--xperf_path', 11:15:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:15:34 INFO - 'tests': ['tp5n']}, 11:15:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:34 INFO - 'talos_options': ['--xperf_path', 11:15:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:15:34 INFO - 'tests': ['tp5n']}}, 11:15:34 INFO - 'talos.zip': {'path': '', 11:15:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:15:34 INFO - Running post-action listener: _resource_record_post_action 11:15:34 INFO - ##### 11:15:34 INFO - ##### Finished populate-webroot step (success) 11:15:34 INFO - ##### 11:15:34 INFO - ##### 11:15:34 INFO - ##### Running create-virtualenv step. 11:15:34 INFO - ##### 11:15:34 INFO - Running pre-action listener: _resource_record_pre_action 11:15:34 INFO - Running main action method: create_virtualenv 11:15:34 INFO - Creating virtualenv /builds/slave/test/build/venv 11:15:34 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 11:15:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:15:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:15:34 INFO - Using real prefix '/tools/python27' 11:15:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:15:35 INFO - Installing distribute.............................................................................................................................................................................................done. 11:15:38 INFO - Installing pip.................done. 11:15:38 INFO - Return code: 0 11:15:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c763a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7c35976a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6c7d30>, '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 0x10c42cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6bfb20>, '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.3Haw4K7foI/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.vZzXE4SEUQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 11:15:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:15:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:15:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Haw4K7foI/Render', 11:15:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:15:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:15:38 INFO - 'HOME': '/Users/cltbld', 11:15:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:15:38 INFO - 'LOGNAME': 'cltbld', 11:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:38 INFO - 'MOZ_NO_REMOTE': '1', 11:15:38 INFO - 'NO_EM_RESTART': '1', 11:15:38 INFO - 'PAGER': '/bin/cat', 11:15:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:38 INFO - 'PWD': '/builds/slave/test', 11:15:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:15:38 INFO - 'SHELL': '/bin/bash', 11:15:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vZzXE4SEUQ/Listeners', 11:15:38 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 11:15:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:15:38 INFO - 'USER': 'cltbld', 11:15:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:15:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:38 INFO - 'XPC_FLAGS': '0x0', 11:15:38 INFO - 'XPC_SERVICE_NAME': '0', 11:15:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:15:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:38 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 11:15:38 INFO - Cleaning up... 11:15:38 INFO - Return code: 0 11:15:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c763a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7c35976a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6c7d30>, '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 0x10c42cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6bfb20>, '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.3Haw4K7foI/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.vZzXE4SEUQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 11:15:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:15:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:15:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Haw4K7foI/Render', 11:15:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:15:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:15:38 INFO - 'HOME': '/Users/cltbld', 11:15:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:15:38 INFO - 'LOGNAME': 'cltbld', 11:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:38 INFO - 'MOZ_NO_REMOTE': '1', 11:15:38 INFO - 'NO_EM_RESTART': '1', 11:15:38 INFO - 'PAGER': '/bin/cat', 11:15:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:38 INFO - 'PWD': '/builds/slave/test', 11:15:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:15:38 INFO - 'SHELL': '/bin/bash', 11:15:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vZzXE4SEUQ/Listeners', 11:15:38 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 11:15:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:15:38 INFO - 'USER': 'cltbld', 11:15:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:15:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:38 INFO - 'XPC_FLAGS': '0x0', 11:15:38 INFO - 'XPC_SERVICE_NAME': '0', 11:15:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:15:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:38 INFO - Downloading/unpacking psutil>=3.1.1 11:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:15:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:15:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:15:41 INFO - Installing collected packages: psutil 11:15:41 INFO - Running setup.py install for psutil 11:15:41 INFO - building 'psutil._psutil_osx' extension 11:15:41 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 11:15:41 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 11:15:41 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 11:15:42 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 11:15:42 INFO - building 'psutil._psutil_posix' extension 11:15:42 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 11:15:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:15:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:15:42 INFO - ^ 11:15:42 INFO - 1 warning generated. 11:15:42 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 11:15:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:15:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:15:42 INFO - Successfully installed psutil 11:15:42 INFO - Cleaning up... 11:15:42 INFO - Return code: 0 11:15:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:42 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c763a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7c35976a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6c7d30>, '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 0x10c42cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6bfb20>, '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.3Haw4K7foI/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.vZzXE4SEUQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 11:15:42 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.3'] in /builds/slave/test/build 11:15:42 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.3 11:15:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Haw4K7foI/Render', 11:15:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:15:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:15:42 INFO - 'HOME': '/Users/cltbld', 11:15:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:15:42 INFO - 'LOGNAME': 'cltbld', 11:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:42 INFO - 'MOZ_NO_REMOTE': '1', 11:15:42 INFO - 'NO_EM_RESTART': '1', 11:15:42 INFO - 'PAGER': '/bin/cat', 11:15:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:42 INFO - 'PWD': '/builds/slave/test', 11:15:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:15:42 INFO - 'SHELL': '/bin/bash', 11:15:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vZzXE4SEUQ/Listeners', 11:15:42 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 11:15:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:15:42 INFO - 'USER': 'cltbld', 11:15:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:15:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:42 INFO - 'XPC_FLAGS': '0x0', 11:15:42 INFO - 'XPC_SERVICE_NAME': '0', 11:15:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:15:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:15:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:15:45 INFO - Installing collected packages: mozsystemmonitor 11:15:45 INFO - Running setup.py install for mozsystemmonitor 11:15:45 INFO - Successfully installed mozsystemmonitor 11:15:45 INFO - Cleaning up... 11:15:45 INFO - Return code: 0 11:15:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:45 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c763a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7c35976a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6c7d30>, '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 0x10c42cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6bfb20>, '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.3Haw4K7foI/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.vZzXE4SEUQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 11:15:45 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==2.5.1'] in /builds/slave/test/build 11:15:45 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==2.5.1 11:15:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Haw4K7foI/Render', 11:15:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:15:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:15:45 INFO - 'HOME': '/Users/cltbld', 11:15:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:15:45 INFO - 'LOGNAME': 'cltbld', 11:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:45 INFO - 'MOZ_NO_REMOTE': '1', 11:15:45 INFO - 'NO_EM_RESTART': '1', 11:15:45 INFO - 'PAGER': '/bin/cat', 11:15:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:45 INFO - 'PWD': '/builds/slave/test', 11:15:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:15:45 INFO - 'SHELL': '/bin/bash', 11:15:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vZzXE4SEUQ/Listeners', 11:15:45 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 11:15:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:15:45 INFO - 'USER': 'cltbld', 11:15:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:15:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:45 INFO - 'XPC_FLAGS': '0x0', 11:15:45 INFO - 'XPC_SERVICE_NAME': '0', 11:15:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:15:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:45 INFO - Downloading/unpacking jsonschema==2.5.1 11:15:45 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 11:15:45 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 11:15:45 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 11:15:45 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 11:15:45 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 11:15:45 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 11:15:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:15:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:48 INFO - Downloading functools32-3.2.3-2.tar.gz 11:15:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:15:48 INFO - warning: no files found matching '*.txt' 11:15:48 INFO - no previously-included directories found matching 'build' 11:15:48 INFO - no previously-included directories found matching 'dist' 11:15:48 INFO - no previously-included directories found matching '.git*' 11:15:48 INFO - Installing collected packages: jsonschema, functools32 11:15:48 INFO - Running setup.py install for functools32 11:15:48 INFO - warning: no files found matching '*.txt' 11:15:48 INFO - no previously-included directories found matching 'build' 11:15:48 INFO - no previously-included directories found matching 'dist' 11:15:48 INFO - no previously-included directories found matching '.git*' 11:15:48 INFO - Successfully installed jsonschema functools32 11:15:48 INFO - Cleaning up... 11:15:48 INFO - Return code: 0 11:15:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:48 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 0x10c763a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7c35976a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6c7d30>, '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 0x10c42cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6bfb20>, '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.3Haw4K7foI/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.vZzXE4SEUQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 11:15:48 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 11:15:48 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 11:15:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Haw4K7foI/Render', 11:15:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:15:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:15:48 INFO - 'HOME': '/Users/cltbld', 11:15:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:15:48 INFO - 'LOGNAME': 'cltbld', 11:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:48 INFO - 'MOZ_NO_REMOTE': '1', 11:15:48 INFO - 'NO_EM_RESTART': '1', 11:15:48 INFO - 'PAGER': '/bin/cat', 11:15:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:48 INFO - 'PWD': '/builds/slave/test', 11:15:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:15:48 INFO - 'SHELL': '/bin/bash', 11:15:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vZzXE4SEUQ/Listeners', 11:15:48 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 11:15:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:15:48 INFO - 'USER': 'cltbld', 11:15:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:15:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:48 INFO - 'XPC_FLAGS': '0x0', 11:15:48 INFO - 'XPC_SERVICE_NAME': '0', 11:15:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:49 INFO - Downloading/unpacking blobuploader==1.2.4 11:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:51 INFO - Downloading blobuploader-1.2.4.tar.gz 11:15:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:15:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:51 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 11:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:15:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:52 INFO - Downloading docopt-0.6.1.tar.gz 11:15:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:15:52 INFO - Installing collected packages: blobuploader, requests, docopt 11:15:52 INFO - Running setup.py install for blobuploader 11:15:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:15:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:15:53 INFO - Running setup.py install for requests 11:15:53 INFO - Running setup.py install for docopt 11:15:53 INFO - Successfully installed blobuploader requests docopt 11:15:53 INFO - Cleaning up... 11:15:53 INFO - Return code: 0 11:15:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:15:53 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')]} 11:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:53 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')]} 11:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:53 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 0x10c763a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7c35976a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6c7d30>, '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 0x10c42cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6bfb20>, '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.3Haw4K7foI/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.vZzXE4SEUQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 11:15:53 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 11:15:53 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 11:15:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Haw4K7foI/Render', 11:15:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:15:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:15:53 INFO - 'HOME': '/Users/cltbld', 11:15:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:15:53 INFO - 'LOGNAME': 'cltbld', 11:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:53 INFO - 'MOZ_NO_REMOTE': '1', 11:15:53 INFO - 'NO_EM_RESTART': '1', 11:15:53 INFO - 'PAGER': '/bin/cat', 11:15:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:53 INFO - 'PWD': '/builds/slave/test', 11:15:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:15:53 INFO - 'SHELL': '/bin/bash', 11:15:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vZzXE4SEUQ/Listeners', 11:15:53 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 11:15:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:15:53 INFO - 'USER': 'cltbld', 11:15:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:15:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:53 INFO - 'XPC_FLAGS': '0x0', 11:15:53 INFO - 'XPC_SERVICE_NAME': '0', 11:15:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:15:54 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-mRRWmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:15:54 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-My56pT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:15:54 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-STR3FM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:15:54 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-zoAG4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:15:54 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-L8sBS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:15:54 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-lRjV7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:15:54 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-1fDAra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:15:54 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-TPFN_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:15:54 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-G3d7vI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:15:55 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-mLVk3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:15:55 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-GGHCkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:15:55 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-FBdVoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:15:55 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-r7HSqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:15:55 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-495beu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:15:55 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-8ay_Pl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:15:55 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-zSkrgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:15:55 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-qdt3Jz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:15:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:15:55 INFO - Running setup.py install for manifestparser 11:15:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:15:56 INFO - Running setup.py install for mozcrash 11:15:56 INFO - Running setup.py install for mozdebug 11:15:56 INFO - Running setup.py install for mozdevice 11:15:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:15:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:15:56 INFO - Running setup.py install for mozfile 11:15:56 INFO - Running setup.py install for mozhttpd 11:15:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:15:56 INFO - Running setup.py install for mozinfo 11:15:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:15:56 INFO - Running setup.py install for mozInstall 11:15:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:15:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:15:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:15:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:15:57 INFO - Running setup.py install for mozleak 11:15:57 INFO - Running setup.py install for mozlog 11:15:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:15:57 INFO - Running setup.py install for moznetwork 11:15:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:15:57 INFO - Running setup.py install for mozprocess 11:15:57 INFO - Running setup.py install for mozprofile 11:15:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:15:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:15:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:15:57 INFO - Running setup.py install for mozrunner 11:15:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:15:58 INFO - Running setup.py install for mozscreenshot 11:15:58 INFO - Running setup.py install for moztest 11:15:58 INFO - Running setup.py install for mozversion 11:15:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:15:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:15:58 INFO - Cleaning up... 11:15:58 INFO - Return code: 0 11:15:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:15: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')]} 11:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15: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')]} 11:15:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:58 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 0x10c763a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7c35976a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6c7d30>, '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 0x10c42cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6bfb20>, '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.3Haw4K7foI/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.vZzXE4SEUQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 11:15:58 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 11:15:58 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 11:15:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Haw4K7foI/Render', 11:15:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:15:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:15:58 INFO - 'HOME': '/Users/cltbld', 11:15:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:15:58 INFO - 'LOGNAME': 'cltbld', 11:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:58 INFO - 'MOZ_NO_REMOTE': '1', 11:15:58 INFO - 'NO_EM_RESTART': '1', 11:15:58 INFO - 'PAGER': '/bin/cat', 11:15:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:58 INFO - 'PWD': '/builds/slave/test', 11:15:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:15:58 INFO - 'SHELL': '/bin/bash', 11:15:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vZzXE4SEUQ/Listeners', 11:15:58 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 11:15:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:15:58 INFO - 'USER': 'cltbld', 11:15:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:15:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:58 INFO - 'XPC_FLAGS': '0x0', 11:15:58 INFO - 'XPC_SERVICE_NAME': '0', 11:15:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:15:58 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-0a1Spj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:15:58 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)) 11:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:15:58 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-WYDFmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:15:58 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)) 11:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:15:58 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-al7nbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:15:59 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)) 11:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:15:59 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-ZFo5YW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:15:59 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)) 11:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:15:59 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-0VXFSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:15:59 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)) 11:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:15:59 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-XdfYqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:15:59 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)) 11:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:15:59 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-8ZO6JO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:15:59 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)) 11:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:15:59 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-lGiwtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:15:59 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)) 11:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:15:59 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-_oBwON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:15:59 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)) 11:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:15:59 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-O6U2WE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 11:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:15:59 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-twU72F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:15:59 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)) 11:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:15:59 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-9oWBVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:16:00 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)) 11:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:16:00 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-JLn3Ta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:16:00 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)) 11:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:16:00 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-_OWilL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:16:00 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)) 11:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:00 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-fqhmOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:00 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)) 11:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:16:00 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-gTKhvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:16:00 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)) 11:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:16:00 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-dy1Ht8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:16:00 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)) 11:16:00 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)) 11:16:00 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)) 11:16:00 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)) 11:16:00 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)) 11:16:00 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)) 11:16:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:02 INFO - Downloading blessings-1.6.tar.gz 11:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:16:03 INFO - Installing collected packages: blessings 11:16:03 INFO - Running setup.py install for blessings 11:16:03 INFO - Successfully installed blessings 11:16:03 INFO - Cleaning up... 11:16:03 INFO - Return code: 0 11:16:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:16:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:16:03 INFO - Reading from file tmpfile_stdout 11:16:03 INFO - Current package versions: 11:16:03 INFO - blessings == 1.6 11:16:03 INFO - blobuploader == 1.2.4 11:16:03 INFO - docopt == 0.6.1 11:16:03 INFO - functools32 == 3.2.3-2 11:16:03 INFO - jsonschema == 2.5.1 11:16:03 INFO - manifestparser == 1.1 11:16:03 INFO - mozInstall == 1.12 11:16:03 INFO - mozcrash == 0.17 11:16:03 INFO - mozdebug == 0.1 11:16:03 INFO - mozdevice == 0.48 11:16:03 INFO - mozfile == 1.2 11:16:03 INFO - mozhttpd == 0.7 11:16:03 INFO - mozinfo == 0.9 11:16:03 INFO - mozleak == 0.1 11:16:03 INFO - mozlog == 3.2 11:16:03 INFO - moznetwork == 0.27 11:16:03 INFO - mozprocess == 0.22 11:16:03 INFO - mozprofile == 0.28 11:16:03 INFO - mozrunner == 6.11 11:16:03 INFO - mozscreenshot == 0.1 11:16:03 INFO - mozsystemmonitor == 0.3 11:16:03 INFO - moztest == 0.7 11:16:03 INFO - mozversion == 1.4 11:16:03 INFO - psutil == 3.1.1 11:16:03 INFO - requests == 1.2.3 11:16:03 INFO - wsgiref == 0.1.2 11:16:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:03 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 0x10c763a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7c35976a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6c7d30>, '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 0x10c42cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6bfb20>, '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.3Haw4K7foI/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.vZzXE4SEUQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 11:16:03 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 11:16:03 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 11:16:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Haw4K7foI/Render', 11:16:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:16:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:16:03 INFO - 'HOME': '/Users/cltbld', 11:16:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:16:03 INFO - 'LOGNAME': 'cltbld', 11:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:03 INFO - 'MOZ_NO_REMOTE': '1', 11:16:03 INFO - 'NO_EM_RESTART': '1', 11:16:03 INFO - 'PAGER': '/bin/cat', 11:16:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:03 INFO - 'PWD': '/builds/slave/test', 11:16:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:16:03 INFO - 'SHELL': '/bin/bash', 11:16:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vZzXE4SEUQ/Listeners', 11:16:03 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 11:16:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:16:03 INFO - 'USER': 'cltbld', 11:16:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:16:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:03 INFO - 'XPC_FLAGS': '0x0', 11:16:03 INFO - 'XPC_SERVICE_NAME': '0', 11:16:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:03 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)) 11:16:03 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)) 11:16:03 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)) 11:16:03 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)) 11:16:03 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)) 11:16:03 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)) 11:16:03 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)) 11:16:03 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)) 11:16:03 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)) 11:16:03 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)) 11:16:03 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)) 11:16:03 INFO - Cleaning up... 11:16:03 INFO - Return code: 0 11:16:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:03 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 0x10c763a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7c35976a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6c7d30>, '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 0x10c42cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6bfb20>, '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.3Haw4K7foI/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.vZzXE4SEUQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 11:16:03 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 11:16:03 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 11:16:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Haw4K7foI/Render', 11:16:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:16:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:16:03 INFO - 'HOME': '/Users/cltbld', 11:16:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:16:03 INFO - 'LOGNAME': 'cltbld', 11:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:03 INFO - 'MOZ_NO_REMOTE': '1', 11:16:03 INFO - 'NO_EM_RESTART': '1', 11:16:03 INFO - 'PAGER': '/bin/cat', 11:16:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:03 INFO - 'PWD': '/builds/slave/test', 11:16:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:16:03 INFO - 'SHELL': '/bin/bash', 11:16:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vZzXE4SEUQ/Listeners', 11:16:03 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 11:16:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:16:03 INFO - 'USER': 'cltbld', 11:16:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:16:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:03 INFO - 'XPC_FLAGS': '0x0', 11:16:03 INFO - 'XPC_SERVICE_NAME': '0', 11:16:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:16:04 INFO - Cleaning up... 11:16:04 INFO - Return code: 0 11:16:04 INFO - Running post-action listener: _resource_record_post_action 11:16:04 INFO - Running post-action listener: _start_resource_monitoring 11:16:04 INFO - Starting resource monitoring. 11:16:04 INFO - ##### 11:16:04 INFO - ##### Finished create-virtualenv step (success) 11:16:04 INFO - ##### 11:16:04 INFO - ##### 11:16:04 INFO - ##### Running install step. 11:16:04 INFO - ##### 11:16:04 INFO - Running pre-action listener: _resource_record_pre_action 11:16:04 INFO - Running main action method: install 11:16:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:16:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:16:04 INFO - Reading from file tmpfile_stdout 11:16:04 INFO - Detecting whether we're running mozinstall >=1.0... 11:16:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:16:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:16:04 INFO - Reading from file tmpfile_stdout 11:16:04 INFO - Output received: 11:16:04 INFO - Usage: mozinstall [options] installer 11:16:04 INFO - Options: 11:16:04 INFO - -h, --help show this help message and exit 11:16:04 INFO - -d DEST, --destination=DEST 11:16:04 INFO - Directory to install application into. [default: 11:16:04 INFO - "/builds/slave/test"] 11:16:04 INFO - --app=APP Application being installed. [default: firefox] 11:16:04 INFO - mkdir: /builds/slave/test/build/application 11:16:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:16:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:16:39 INFO - Reading from file tmpfile_stdout 11:16:39 INFO - Output received: 11:16:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:16:39 INFO - Running post-action listener: _resource_record_post_action 11:16:39 INFO - ##### 11:16:39 INFO - ##### Finished install step (success) 11:16:39 INFO - ##### 11:16:39 INFO - ##### 11:16:39 INFO - ##### Running run-tests step. 11:16:39 INFO - ##### 11:16:39 INFO - Running pre-action listener: _resource_record_pre_action 11:16:39 INFO - Running main action method: run_tests 11:16:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:16:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:16:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:16:39 INFO - 2016-06-29 11:16:39.582 screenresolution[1949:17898] starting screenresolution argv=screenresolution get 11:16:39 INFO - 2016-06-29 11:16:39.585 screenresolution[1949:17898] Display 0: 1600x1200x32@60 11:16:39 INFO - 2016-06-29 11:16:39.591 screenresolution[1950:17900] starting screenresolution argv=screenresolution list 11:16:39 INFO - Available Modes on Display 0 11:16:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:16:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:16:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:16:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:16:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:16:39 INFO - Intel Iris: 11:16:39 INFO - Chipset Model: Intel Iris 11:16:39 INFO - Type: GPU 11:16:39 INFO - Bus: Built-In 11:16:39 INFO - VRAM (Dynamic, Max): 1536 MB 11:16:39 INFO - Vendor: Intel (0x8086) 11:16:39 INFO - Device ID: 0x0a2e 11:16:39 INFO - Revision ID: 0x0009 11:16:39 INFO - Displays: 11:16:39 INFO - Display: 11:16:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:16:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:16:39 INFO - Display Serial Number: 1600x1200 60 11:16:39 INFO - Main Display: Yes 11:16:39 INFO - Mirror: Off 11:16:39 INFO - Online: Yes 11:16:39 INFO - Rotation: Supported 11:16:39 INFO - Return code: 0 11:16:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:16:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:16:39 INFO - Python 2.7.3 11:16:39 INFO - Return code: 0 11:16:39 INFO - grabbing minidump binary from tooltool 11:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:39 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6c7d30>, '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 0x10c42cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6bfb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:16:39 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 11:16:39 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 11:16:39 INFO - Calling ['/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'] with output_timeout 600 11:16:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:16:39 INFO - Return code: 0 11:16:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:16:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:16:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:16:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:16:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:16:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0105', '--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 11:16:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0105 --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 11:16:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Haw4K7foI/Render', 11:16:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:16:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:16:39 INFO - 'HOME': '/Users/cltbld', 11:16:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:16:39 INFO - 'LOGNAME': 'cltbld', 11:16:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:16:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:39 INFO - 'MOZ_NO_REMOTE': '1', 11:16:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:16:39 INFO - 'NO_EM_RESTART': '1', 11:16:39 INFO - 'PAGER': '/bin/cat', 11:16:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:39 INFO - 'PWD': '/builds/slave/test', 11:16:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:16:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:16:39 INFO - 'SHELL': '/bin/bash', 11:16:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vZzXE4SEUQ/Listeners', 11:16:39 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 11:16:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:16:39 INFO - 'USER': 'cltbld', 11:16:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:16:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:39 INFO - 'XPC_FLAGS': '0x0', 11:16:39 INFO - 'XPC_SERVICE_NAME': '0', 11:16:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:16:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0105', '--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 11:16:40 INFO - mozversion application_buildid: 20160629085825 11:16:40 INFO - mozversion application_changeset: a470d1809acea1d1b6139a962d137b436578317a 11:16:40 INFO - mozversion application_display_name: Nightly 11:16:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:16:40 INFO - mozversion application_name: Firefox 11:16:40 INFO - mozversion application_remotingname: firefox 11:16:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:16:40 INFO - mozversion application_vendor: Mozilla 11:16:40 INFO - mozversion application_version: 50.0a1 11:16:40 INFO - mozversion platform_buildid: 20160629085825 11:16:40 INFO - mozversion platform_changeset: a470d1809acea1d1b6139a962d137b436578317a 11:16:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:16:40 INFO - mozversion platform_version: 50.0a1 11:16:40 INFO - using testdate: 1467224200 11:16:40 INFO - actual date: 1467224200 11:16:40 INFO - starting webserver on 'localhost:53259' 11:16:40 INFO - SUITE-START | Running 2 tests 11:16:40 INFO - TEST-START | dromaeo_css 11:16:40 INFO - operating with platform_type : mac_ 11:16:40 INFO - Initialising browser for dromaeo_css test... 11:16:40 INFO - TEST-INFO | started process 1960 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmppEqBCZ/profile http://localhost:53259/getInfo.html) 11:16:42 INFO - PROCESS | 1960 | __metrics Screen width/height:1600/1200 11:16:42 INFO - PROCESS | 1960 | colorDepth:24 11:16:42 INFO - PROCESS | 1960 | Browser inner width/height: 1024/689 11:16:42 INFO - PROCESS | 1960 | __metrics 11:16:42 INFO - PROCESS | 1960 | 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" 11:16:42 INFO - PROCESS | 1960 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:16:43 INFO - TEST-INFO | 1960: exit 0 11:16:43 INFO - Browser initialized. 11:16:43 INFO - Running cycle 1/1 for dromaeo_css test... 11:16:43 INFO - TEST-INFO | started process 1962 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmppEqBCZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:16:55 INFO - PROCESS | 1962 | RSS: Main: 243425280 11:16:55 INFO - PROCESS | 1962 | 11:17:46 INFO - PROCESS | 1962 | 1467224266841 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] 11:19:57 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:53259/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53259/tests/dromaeo/cssquery-ext.html) 11:19:58 INFO - PROCESS | 1962 | RSS: Main: 334045184 11:19:58 INFO - PROCESS | 1962 | 11:23:01 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:53259/tests/dromaeo/cssquery-ext.html (next: http://localhost:53259/tests/dromaeo/cssquery-jquery.html) 11:23:02 INFO - PROCESS | 1962 | RSS: Main: 375029760 11:23:02 INFO - PROCESS | 1962 | 11:26:04 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:53259/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53259/tests/dromaeo/cssquery-mootools.html) 11:26:05 INFO - PROCESS | 1962 | RSS: Main: 373608448 11:26:05 INFO - PROCESS | 1962 | 11:29:07 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:53259/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53259/tests/dromaeo/cssquery-prototype.html) 11:29:08 INFO - PROCESS | 1962 | RSS: Main: 371838976 11:29:08 INFO - PROCESS | 1962 | 11:32:11 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:53259/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53259/tests/dromaeo/cssquery-yui.html) 11:32:12 INFO - PROCESS | 1962 | RSS: Main: 344080384 11:32:12 INFO - PROCESS | 1962 | 11:35:15 INFO - PROCESS | 1962 | Cycle 1(1): loaded http://localhost:53259/tests/dromaeo/cssquery-yui.html (next: http://localhost:53259/tests/dromaeo/cssquery-dojo.html) 11:35:15 INFO - PROCESS | 1962 | RSS: Main: 388218880 11:35:15 INFO - PROCESS | 1962 | 11:35:15 INFO - PROCESS | 1962 | __start_tp_report 11:35:15 INFO - PROCESS | 1962 | _x_x_mozilla_page_load 11:35:15 INFO - PROCESS | 1962 | _x_x_mozilla_page_load_details 11:35:15 INFO - PROCESS | 1962 | |i|pagename|runs| 11:35:15 INFO - PROCESS | 1962 | |0;dojo.html;3329.9500507492376;3331.500274958756;3345.9627515470197;3353.463445848665;3404.693577578019;5616.157576363547;5658.6038977271555;5701.77192912283;5736.541076713864;5779.075347944325;5672.035753921833;5686.175504551848;5782.710864456771;5785.190073389729;5802.506786923106;5106.106431374513;5132.820351287705;5187.974060129713;5193.766280517367;5290.470952904717;4533.909321813562;5269.473052694719;5297.629165958385;5308.92036619451;5324.227986941891;5121.206213036985;5125.333706618116;5165.483451654804;5194.194899790538;5206.609504287194;5146.7683954221775;5160.716160611165;5174.689518628894;5174.818881339173;5266.210068489719;5131.53816156544;5157.53582177602;5180.989707007135;5227.869303267411;5250.527452529291;5601;5640.294963129609;5746.367899531048;5767.279090113736;5850.736716847709;6175.722092505848;6190.009598464269;6231.937680623181;6233.470155036827;6244.500439964837;6269.059641053833;6281.24625044993;6313.863504569222;6317.178766760292;6347.301796802348;5665.49010589049;5730.226419433407;5832.708364581754;5833.766649334021;5844.620099693507;6221.720022598904;6280.403361680633;6290.528210384239;6298.685065746694;6303.873922521524;6141.9558675025355;6169.722362493699;6170.876582468415;6171.814845554551;6191.721372538156;6096.786612468542;6171.13604095427;6295.842603934847;6298.716557754912;6300.495960323163;5260.237265596544;6141.792871882774;6168.938310616926;6217.658028808369;6241.843953901098;6209.130721698965;6272;6283.937160628335;6291.213598300213;6300.401461861115;4978.377702787152;4993.650444468853;5002.249662550574;5007.298978143063;5033.320501732219;4384.364267181241;4396.1647287016;4485.035717320727;4509.34614480905;4525.162844873709;5686.2323586315315;5688.232088667977;5690.260266165372;5707.1153971134545;5708.65748055118;6118.162361256266;6250.531210159256;6257.56197066201;6274.6548939808745;6346.524010699216;5683.971580142155;5695.316562012585;5697.917395694804;5705.144228365778;5712.857178570486;5293.497117773805;5427.131658934631;5437.564994800407;5438.673679579238;5450.618456708072;5444.50999410055;6201.782937597252;6224.62652240867;6252.531060170414;6287.528435367366;6294.402031806971;6301.338359472189;6320.778772742932;6329.841753956188;6334.9366506334345;6228.875422491616;6256.624602523863;6313.3686631336495;6323;6325.399087086719;6072.969635151796;6166.691665416801;6168.753249869955;6175.59858609189;6193.349698281616;6290.49676025926;6299.622022678654;6306.054091886071;6321.841953951188;6325.272593651789;5956.434138756985;6045.848853778691;6051;6084.574079814371;6090.847728806638;6109.040306147876;6109.586862300737;6122.306673174842;6127.128444391353;6127.464420129145;5832.329282132439;5897;5963.13534537481;5969.791057312973;6055;5813.215215945962;6090.786822461193;6091.1472393864005;6101.095933926387;6146.508279337731;5956.076808094752;5970.9701451492465;5974.342822289632;5978.581499295007;6024.518038556817 11:35:15 INFO - PROCESS | 1962 | |1;ext.html;462.8287533612562;477.72530794793;524.7323864828937;525.9789608415662;542.9538489228415;29579.852100739492;29859.70140298599;29914.85042574784;30018.549721754163;40204.19591608166;39825.601743982625;42887;42889.284428622894;42984;42989.7850510747;9601.663941762039;9802.803943921117;9803.950980245088;9813.018698130165;9821.066998635153;9562.474063926482;9675.129238368545;9676.709698709015;9683.709488715349;9693.854592181124;9628.422294662309;9701.369410988298;9702.320837541374;9716;9721.562529686182;9619.951900240489;9670.70987870358;9680.854787178198;9690.176335011533;9693.030696930322;9578.281628877792;9627.181689556395;9650.034996500364;9654.27592930533;9659.90340096597;40415;40890.59109408897;40908;40933;41033;3340.6993370596765;3399.6426682104375;3954.8418063277436;4090.6931980101613;4292;32256.677433225836;32472.6752732472;32525.349493010006;32542.349153016807;32556.02331930046;3195;3453.4301840196335;3468.514407982884;3469.3755124077657;3475.600305964821;525495;525729;527053;527239.9999999962;528219.9999999962;59510;59653.70173149106;59659.70170149121;59722.40277597255;59841;62625.11123776381;62662.686686566274;62703.37296627067;62749;62848.371516285166;14114.294285285694;15588.454404096028;16411.507654770136;16636.334546618;16663.91668041652;11663.542057242845;11938.164328496921;11939.343336116597;11985.16103872738;12648.304343261025;15592.92203538975;15880.920595396949;15886.285117169755;15916.283767230503;15931.522054338388;4347.345279538544;6560.081588577603;7056.964715176391;7667.738017284914;7792.740105369379;871.311663785615;903.7753843542038;965.6909788867495;970.9951450242703;984.8128855517429;28755.849766009545;30405.391892162475;31355.686443135277;31930;32337.35325293481;1025.707673313117;1049.9370037797758;1081.9513121909533;1086.1853609792656;1131.3212072756444;15209.315580798891;15704;15778.97436666613;15799;16087.356505739874;674750;688672;694478.5276073588;695813;696369;57897.42102579005;58328.416715832296;58351;58456;58572;1256.0956111599633;1381.8203633527778;1403.0248976960913;1415.575327401796;1417.4684493315008;30784.384312314076;30792.53811192789;31072.22319442032;31717.68282317147;31765;43717.78141109274;56601.43398565962;57524;57603.1359529599;60875.12998960161;640381;642300;649917;650420;651223;35258.8237058813;36189.457158143174;36747.44878826766;43709.78145109381;45516.54483455256;44542.88642783827;44922;45751.77124114358;45829.54170458253;45890.85272868205;33070.66929330772;37322.81338593398;39523.011924702114;39989;40216;39785.00537486586;40060.80507106363;40164.3975340376;40672.79663601663;40859.387109192794;38282.61717382791;38407.61592384041;39031.02422439462;39036.414453783786;39040.80479597584;33918.491222631186;34079.48880766741;35152.66049725272;35168.824155879054;35279.823600881835;25307.114251001127;25320.746792532576;25469.4032497339;25869.48261034731;26194 11:35:15 INFO - PROCESS | 1962 | |2;jquery.html;332.86518959821274;352.13726370392544;376.7325199108632;386.84719535783364;400.867713654494;14596.78104828427;15648.452304169356;20931.16275348988;21003.94980250985;22172.223972160937;20914;21024.789752102475;21426.678599821014;22032;22096.88951555244;5828.475437210661;6051.939480605203;6097.847553811146;6106.755729770804;6109.327973922865;4166.64583510402;4402.581754733295;5997.280326360843;6741.224759152711;6743.35938085881;5891.322497912731;6699.296573859748;6705.362990515918;6706.798796036102;6708.127943367355;6358.713857876407;6648.03603477493;6656.334366563354;6658.334166583351;6660.467162626978;3722.3671975764187;3916.15802602439;3943.921121577552;3950.486436763202;5719.370869204384;25320.493590128277;26135;26249.868750656315;26743.796529156236;26964.325891852666;2208.492046829222;2233.7319521657505;2444.0346063305074;2579.290695058855;2780.9443811123865;14528.927355363156;14992.700145997129;15375.769363459556;15927.96468229573;16598.170091495496;1791.3909270847973;1847.9750963827296;1854.6476169527746;1865.4496923407492;1876.418310323804;111160.88839111586;111246.44376778146;112034.42691777236;112902.43548782286;113401.86598133996;8758.605862736193;9069.77325566866;9978.401295922267;10613.416262105658;11002.614908478165;12998.805017924738;13033.283169425584;13048.34758262083;13052.282124483054;13052.412641430969;7563.546187228784;7997;8084.595770211584;8144.837103257902;8152.021757389151;8541.572921354033;8822;8879.866801997976;8985.685501007434;8999.82000359989;5686.237266447414;6607.603543787388;6703.698333575001;6726.495512836557;6797.334653010044;1823.4165067178642;1829.5883426228993;1829.7529833472577;1830.734543491213;1847.5842935339442;890.7372325164092;909.1090731083575;925.4123631493915;957.5451660461225;989.5695372512836;22637.773622263896;22824.97287622061;22900.083996639947;23115.422114446937;23204.419889502897;992.4640694025146;1018.4042335233823;1024.7643042100358;1030.8093002794508;1039.443897514826;10560.683179504627;11167.441627918572;11754.294742315318;12119.939400302943;12156.574519891761;541411.2929435328;599231;608269;611604;613252.9337353285;113194;113195.43402282936;114805;114906;117613;989.7278248481581;997.8247420622967;1005.2862467647906;1020.6733845169623;1022.2384323678907;18860.52848678794;19866.10602522861;20132.496687582927;20159.193632255134;20215.29246476425;51211.487885120674;53378;53411.4658853422;53576.196357053894;53600.73199633977;61380.93095345304;62355;63244.68377658082;73574.63212683902;74870.87693684708;7029.191642961125;7736.535807851547;7975.042994840656;8117.431779775359;8334.708285209988;11097;13503.59489215325;13597.116187447784;13736.175829450265;13744;11496.482658280565;11563.479643415898;11694.47374868116;11833.644990650295;11886.465109069939;11310.547578096784;11587.073034157078;11650.126240531825;11703.414829258674;11759.176857619885;11625.069994400597;11778.469968851594;11897.977343851393;12100.757984840078;12115.575954841539;7982.201779821971;8036.236557527026;8088.757337279891;8306;8317.875231871647;11684.240524366229;11710;11881.643550693492;11902.988245999188;11913.987311078656 11:35:15 INFO - PROCESS | 1962 | |3;mootools.html;1485.064409422064;1522.9695406091878;1691.8984860908347;1817.6730986379935;1862.8882267063968;8377.287930525905;8636.870446943301;8808.251298639607;8829.779255518608;8839.867401988975;7750.069991601016;8019.599020049003;8417.410781245315;8605.741827745162;8653.350998675092;2347.2371479269177;2374.9762502375015;2376.9881150594224;2378.143868207444;2378.5480758655885;2348.3424641100432;2362.1024010875844;2389.0682633772844;2393.44950661348;2394.916177933773;2096.4549217203485;2174.739031316244;2306.7231932168165;2375.5011447596025;2379.524095180962;2352.023910077316;2360.728516220631;2380.5595964746403;2381.8094552435764;2395.8802059896934;2103.747550293959;2307.4231442139467;2370.2415227127326;2380.7262164850918;2383.749706280833;8805.987311459201;8862.335324850663;8873.46759194444;8884.600192991331;8897.822043559092;5202.401723801773;5300.310959575269;5371.650842695212;5383.246345511631;5389.622726409153;3581.1405262736757;3590.4793804898404;3648.142686468704;3658.1220507078374;3662.450632405134;1075.714935542082;1081.7133459633203;1086.4241951765578;1106.1372129738816;1109.1459576126338;11451.312921224753;11469.197156199069;11470.311781293149;11472.541098356056;11477;4559.042601053749;4569.314602809605;4783.1868582341085;4790.233562629963;4797.18447863864;8658.523781192094;9811.018898110131;9817.116459518678;9819.312648114706;9830.557624906896;5339;5350.6254562180275;5351.09031464652;5366.007288651612;5377.542908852792;4871.95128048715;4889.951100489021;4933.210686290176;4934.087193869145;4963.230699241623;3899.6880249579967;3907.531096268466;3952.980235098806;4022.8390864365097;4037.475128233311;1142.2746555936874;1177.988220117805;1227.613301809927;1261.4512686981193;1270.574357590199;766.2146300042501;842.650300125441;868.0624925080898;880.4849163239577;976.6581696406344;5632.408597097246;5769.624974376652;5935.0503919372695;6007.609505382136;6111.54163437744;906.8685040669066;908.6456282050005;933.262722449271;958.075457183821;966.7873067925045;3945.053187235043;3990.920181596352;4017.915162905999;4050.635442810102;4074;10350.53422595985;10821.296615719953;10822.242443028912;10832.72918177036;10858.837117443245;9818.459984700767;10267.689769801884;10622.840657390145;10773.461326933779;10782;7969.840603187904;8286.627101780434;8297.58512074394;8304.792380190424;8315.792105197297;5937.376575459687;5950.672713000653;5978.432048955342;6080.270367555921;6246.562740608114;9041.547922603975;9876.555555000186;10149.695509134737;10153.593856245667;10191.643292484727;10326.328788628714;10337.4314412705;10347.896521034994;10356.119729822749;10378.844317335095;7008;7059.329363710644;7062.117235345582;7189.964050179716;7201.171865235565;8164.5917704115745;8174.427790054639;8281.17188281167;8281.83436331282;8281.917180828355;7374.594397308199;7483.064616922885;7502.924970750222;7555.357794587521;7664.540127592362;7343.77968660941;7398.408127349691;7418.703251869865;7460.142083660448;7485.47601667878;6923.688434020582;6973;7014.158301003708;7020.5787652741;7021.508494405547;4907;4982.701037937735;5034.496550344937;5058.721770302669;5111.080005599028;5009.123403404316;5047.671901326402;5097.515736005073;5103.43862175153;5219.347581552306 11:35:15 INFO - PROCESS | 1962 | |4;prototype.html;298.82668052529533;298.8655105202659;307.621625400757;312.89205224197656;315.5345864849349;4567.862964111077;5117.334746482952;5312.203169524573;5340.252364668944;5347.786088556462;5084.923726144101;5144.0740666679985;5278.841634750964;5296.364436267643;5301.575873930086;3694.612065733086;3705.5368078990127;4049.914294138521;4054.2904991626497;4066.5120185577625;3020.426119037387;3397.3884700753856;3809.619038096182;4086.7547947123267;4100.17996400721;3051.5117581187014;3167.8891238806646;3431.330890476358;3708.5165933626495;4037.212743515001;3390.3727810354917;3689.907752306187;3882.320593896057;4022.45696830927;4058.6753059755442;3384.5938487381673;3487.354839354702;3500.597431295408;3516.314318707853;3562.2163124112653;4759.5002524734755;5093.319204662453;5149.9485005149845;5151.278820965068;5180.740962951875;4230.492340919079;4490.124425736983;4593.058423023273;4611.4696809866955;4652.906941861178;5547.669978608954;5575.414581468928;5590.496855283044;5616.466435688603;5627.831165065055;3684.3254834994445;3884.7280690351686;3888.4361767543833;3913.2173565287057;3919.3533067043904;4904.975475122637;5253.737313134367;5465.480779325958;5852.76588936442;5865.384134665884;3974.7813870237414;3978.7214894957656;3990.980045099756;3993.5407428145554;4002.0595160137345;3650.324689932371;3933.8819835404984;4009.0956795522475;4032.5765794591143;4040.4141399496907;3994.6032380571423;4475.672650221932;4583.358329833826;4585.541445855454;4605.723656580616;4729.385179926588;5705.375527257508;5717.628354156966;5731.914021289684;5737.684427356452;1253.7743206222785;1287.4528325461642;1289.3553223388305;1330.4545136493991;1335.6594068512468;737.9335859772647;759.6581538307784;797.8284668796236;799.192815256595;812.5124925044926;3852.287326844487;4168.249715051259;4361.607455328972;4367.912641747211;4382.05785756064;4031.07285324377;4369.80335884886;4810.95189048105;4818.301346304836;4823.588205897052;3599.874004409833;4351.303791393362;4365.410669559632;4394.879305777006;4398.956010439919;1930.4787707318944;2299.792608880351;2537.7438168106905;2539.6698429204084;2542.834715743471;4394.450693663292;4408.823647054082;4715.009847931973;4972.8756781080765;4993.725345105981;4215.831366745358;4643.931895664016;4860.007396967227;4882.461120217538;4950.480199579064;4473.865784026484;4882.9755851221225;4918.458969513351;5993.910091348546;6030.216071910536;5210.505002024802;5401.540869026019;5765.625234359753;5768.307803063659;5773.624714393551;5522.5858060644805;5753.856153596026;5788.247527821356;5812.622179558315;5824.592278540462;5196.32447781786;5726.226959360433;5962.718015626661;6007.339192688888;6007.609505382136;3283.589551306087;3600.2979419014086;3876.476675648751;3881.573026967088;3887.8639247626197;5056.7724452399;5261.184516399964;5803.245578074992;5812.883742325214;5852.385499522489;5147.962702005834;5596.720163991703;5646.35066967304;5652.745626446737;5667.319921609268;4715.339852420595;5352;5388.110961691277;5620.943790562042;5645.858853528694;5218.530332270114;5510.9448905510435;5517.613767036269;5539.446055394428;5554.583406244467;5107.9528696617845;5211.557017653542;5651.6043876928225;5668.433156684298;5732.742026608729;5060.898782024413;5500.972495137498;5538.280023597068;5555.250041244381;5584.46947539983 11:35:15 INFO - PROCESS | 1962 | |5;yui.html;780.8711562592173;785.4541093939711;800.4716886854677;802.113664400837;825.3273582030645;14558.199299038548;15645.530634080968;15658.92170539147;15666.138362390078;15674.294656740445;15003.924980375083;15704;15709.371625135009;15712.921435392807;15744.763828542582;687.9036934829128;702.3538344722841;834.4200780457585;847.4533925617973;860.5955201055494;847.4152834544176;848.2959143910571;849.9830003399928;869.5478351257342;874.6107981948036;891.7859713668705;901.2204443156655;901.3645380007111;901.7970956534792;901.8602116671926;718.335539625844;890.0876601483532;896.9910300896972;899.5547204133962;922.3128769067088;637.4517914593446;638.2118084166051;638.7764282501134;659.7558903205845;662.1491383572135;15167.62080947974;15202.619934501616;15218.543443696706;15233.238338083162;15261.61845953849;12439;14732.70534589313;14762.557123286319;14795.852041479555;14873.256337183206;11880.465379057963;12020;12056.457459414347;12243.877561224363;12615.558455454015;3864.516935383077;3921.0785465415606;3927.8036098194975;3941.6452519273116;4053.8783836484954;101678;103246;104276.47861760718;104380;105713;10363.378197308035;11461.54153833854;11527.596534121265;11567.305961642329;11932.403379830974;23619.40951476227;23861;23867.16464923754;23875.04499819988;23881.283561493183;8173.386995975206;8195.139510351446;8195.95902020486;8418.074011858691;8432.662693492191;4475.239209334421;4610.838620648261;4615;4620.0990806793025;4715.475450590428;3605.85576576934;3740.270647223765;3741.6819570336284;3744.857818365425;3917.8236979335998;703.2018658822171;708.8582283543312;709.4785332780402;715.6886754261913;727.1964479250457;518.5048278893647;555.7749111609804;577.2409281794427;604.9546284028715;669.9631520266432;8022.518648881086;8893.799337089411;8906.955465222632;9579.616815327448;9689.757756056155;605.0146790446775;608.3581821178699;643.4016364780799;663.8937769956784;665.9001149827468;4393.275109606943;4575.58819706228;4610.884727881763;4651.744154071558;4769.236922092448;146824;147234;155830;158038.20980895023;158193;132903;136298;136368.31815840857;139686;140908.8863667046;113637;115055.99999999833;116276;116731;118146;7948.960255198687;8991.865122023306;9006.684766033157;9038.09619038091;9172.770680732769;53672.92654146974;55600;56488.4580193884;61391.693041534505;65920.6703966477;87123;87729.56135219283;91229;91973.62039569278;94496.52751736197;13160.407781649657;13686.726265474435;13809.447622095004;13904.115721718537;13919;12989.28558929268;15051.247437628293;15053.250912340458;15468.613284667974;15683;14063.437462501795;14373.353199106274;14505.78241326402;14805.555833325017;15008.324625391666;13759.17444953306;13876.58370248894;14565.27173641335;14648.340824662702;14686.632834178803;13380.866191337962;13656.590302290948;13694.65763355924;14195.503157389441;14387.856121438652;11361.1514223804;11411.885881141083;11484.712882178012;11597.420128993685;12046.156769026435;9673.114417395522;10560.207984401048;11212.943935280271;11447.141464390037;11788.941055294668 11:35:15 INFO - PROCESS | 1962 | __end_tp_report 11:35:15 INFO - PROCESS | 1962 | __start_cc_report 11:35:15 INFO - PROCESS | 1962 | _x_x_mozilla_cycle_collect,1298 11:35:15 INFO - PROCESS | 1962 | __end_cc_report 11:35:15 INFO - PROCESS | 1962 | __startTimestamp1467225315704__endTimestamp 11:35:15 INFO - PROCESS | 1962 | 11:35:15 INFO - PROCESS | 1962 | ------- Summary: start ------- 11:35:15 INFO - PROCESS | 1962 | Number of tests: 6 11:35:15 INFO - PROCESS | 1962 | 11:35:15 INFO - PROCESS | 1962 | [#0] dojo.html Cycles:165 Average:5740.96 Median:5963.14 stddev:643.31 (10.8%) stddev-sans-first:616.85 11:35:15 INFO - PROCESS | 1962 | Values: 3330.0 3331.5 3346.0 3353.5 3404.7 5616.2 5658.6 5701.8 5736.5 5779.1 5672.0 5686.2 5782.7 5785.2 5802.5 5106.1 5132.8 5188.0 5193.8 5290.5 4533.9 5269.5 5297.6 5308.9 5324.2 5121.2 5125.3 5165.5 5194.2 5206.6 5146.8 5160.7 5174.7 5174.8 5266.2 5131.5 5157.5 5181.0 5227.9 5250.5 5601.0 5640.3 5746.4 5767.3 5850.7 6175.7 6190.0 6231.9 6233.5 6244.5 6269.1 6281.2 6313.9 6317.2 6347.3 5665.5 5730.2 5832.7 5833.8 5844.6 6221.7 6280.4 6290.5 6298.7 6303.9 6142.0 6169.7 6170.9 6171.8 6191.7 6096.8 6171.1 6295.8 6298.7 6300.5 5260.2 6141.8 6168.9 6217.7 6241.8 6209.1 6272.0 6283.9 6291.2 6300.4 4978.4 4993.7 5002.2 5007.3 5033.3 4384.4 4396.2 4485.0 4509.3 4525.2 5686.2 5688.2 5690.3 5707.1 5708.7 6118.2 6250.5 6257.6 6274.7 6346.5 5684.0 5695.3 5697.9 5705.1 5712.9 5293.5 5427.1 5437.6 5438.7 5450.6 5444.5 6201.8 6224.6 6252.5 6287.5 6294.4 6301.3 6320.8 6329.8 6334.9 6228.9 6256.6 6313.4 6323.0 6325.4 6073.0 6166.7 6168.8 6175.6 6193.3 6290.5 6299.6 6306.1 6321.8 6325.3 5956.4 6045.8 6051.0 6084.6 6090.8 6109.0 6109.6 6122.3 6127.1 6127.5 5832.3 5897.0 5963.1 5969.8 6055.0 5813.2 6090.8 6091.1 6101.1 6146.5 5956.1 5971.0 5974.3 5978.6 6024.5 11:35:15 INFO - PROCESS | 1962 | 11:35:15 INFO - PROCESS | 1962 | [#1] ext.html Cycles:180 Average:74926.08 Median:40920.50 stddev:167380.28 (409.0%) stddev-sans-first:167756.46 11:35:15 INFO - PROCESS | 1962 | Values: 462.8 477.7 524.7 526.0 543.0 29579.9 29859.7 29914.9 30018.5 40204.2 39825.6 42887.0 42889.3 42984.0 42989.8 9601.7 9802.8 9804.0 9813.0 9821.1 9562.5 9675.1 9676.7 9683.7 9693.9 9628.4 9701.4 9702.3 9716.0 9721.6 9620.0 9670.7 9680.9 9690.2 9693.0 9578.3 9627.2 9650.0 9654.3 9659.9 40415.0 40890.6 40908.0 40933.0 41033.0 3340.7 3399.6 3954.8 4090.7 4292.0 32256.7 32472.7 32525.3 32542.3 32556.0 3195.0 3453.4 3468.5 3469.4 3475.6 525495.0 525729.0 527053.0 527240.0 528220.0 59510.0 59653.7 59659.7 59722.4 59841.0 62625.1 62662.7 62703.4 62749.0 62848.4 14114.3 15588.5 16411.5 16636.3 16663.9 11663.5 11938.2 11939.3 11985.2 12648.3 15592.9 15880.9 15886.3 15916.3 15931.5 4347.3 6560.1 7057.0 7667.7 7792.7 871.3 903.8 965.7 971.0 984.8 28755.8 30405.4 31355.7 31930.0 32337.4 1025.7 1049.9 1082.0 1086.2 1131.3 15209.3 15704.0 15779.0 15799.0 16087.4 674750.0 688672.0 694478.5 695813.0 696369.0 57897.4 58328.4 58351.0 58456.0 58572.0 1256.1 1381.8 1403.0 1415.6 1417.5 30784.4 30792.5 31072.2 31717.7 31765.0 43717.8 56601.4 57524.0 57603.1 60875.1 640381.0 642300.0 649917.0 650420.0 651223.0 35258.8 36189.5 36747.4 43709.8 45516.5 44542.9 44922.0 45751.8 45829.5 45890.9 33070.7 37322.8 39523.0 39989.0 40216.0 39785.0 40060.8 40164.4 40672.8 40859.4 38282.6 38407.6 39031.0 39036.4 39040.8 33918.5 34079.5 35152.7 35168.8 35279.8 25307.1 25320.7 25469.4 25869.5 26194.0 11:35:15 INFO - PROCESS | 1962 | 11:35:15 INFO - PROCESS | 1962 | [#2] jquery.html Cycles:180 Average:34420.48 Median:12824.23 stddev:98766.36 (770.2%) stddev-sans-first:99010.26 11:35:15 INFO - PROCESS | 1962 | Values: 332.9 352.1 376.7 386.8 400.9 14596.8 15648.5 20931.2 21003.9 22172.2 20914.0 21024.8 21426.7 22032.0 22096.9 5828.5 6051.9 6097.8 6106.8 6109.3 4166.6 4402.6 5997.3 6741.2 6743.4 5891.3 6699.3 6705.4 6706.8 6708.1 6358.7 6648.0 6656.3 6658.3 6660.5 3722.4 3916.2 3943.9 3950.5 5719.4 25320.5 26135.0 26249.9 26743.8 26964.3 2208.5 2233.7 2444.0 2579.3 2780.9 14528.9 14992.7 15375.8 15928.0 16598.2 1791.4 1848.0 1854.6 1865.4 1876.4 111160.9 111246.4 112034.4 112902.4 113401.9 8758.6 9069.8 9978.4 10613.4 11002.6 12998.8 13033.3 13048.3 13052.3 13052.4 7563.5 7997.0 8084.6 8144.8 8152.0 8541.6 8822.0 8879.9 8985.7 8999.8 5686.2 6607.6 6703.7 6726.5 6797.3 1823.4 1829.6 1829.8 1830.7 1847.6 890.7 909.1 925.4 957.5 989.6 22637.8 22825.0 22900.1 23115.4 23204.4 992.5 1018.4 1024.8 1030.8 1039.4 10560.7 11167.4 11754.3 12119.9 12156.6 541411.3 599231.0 608269.0 611604.0 613252.9 113194.0 113195.4 114805.0 114906.0 117613.0 989.7 997.8 1005.3 1020.7 1022.2 18860.5 19866.1 20132.5 20159.2 20215.3 51211.5 53378.0 53411.5 53576.2 53600.7 61380.9 62355.0 63244.7 73574.6 74870.9 7029.2 7736.5 7975.0 8117.4 8334.7 11097.0 13503.6 13597.1 13736.2 13744.0 11496.5 11563.5 11694.5 11833.6 11886.5 11310.5 11587.1 11650.1 11703.4 11759.2 11625.1 11778.5 11898.0 12100.8 12115.6 7982.2 8036.2 8088.8 8306.0 8317.9 11684.2 11710.0 11881.6 11903.0 11914.0 11:35:15 INFO - PROCESS | 1962 | 11:35:15 INFO - PROCESS | 1962 | [#3] mootools.html Cycles:180 Average:5702.07 Median:5041.08 stddev:3161.78 (62.7%) stddev-sans-first:3154.77 11:35:15 INFO - PROCESS | 1962 | Values: 1485.1 1523.0 1691.9 1817.7 1862.9 8377.3 8636.9 8808.3 8829.8 8839.9 7750.1 8019.6 8417.4 8605.7 8653.4 2347.2 2375.0 2377.0 2378.1 2378.5 2348.3 2362.1 2389.1 2393.4 2394.9 2096.5 2174.7 2306.7 2375.5 2379.5 2352.0 2360.7 2380.6 2381.8 2395.9 2103.7 2307.4 2370.2 2380.7 2383.7 8806.0 8862.3 8873.5 8884.6 8897.8 5202.4 5300.3 5371.7 5383.2 5389.6 3581.1 3590.5 3648.1 3658.1 3662.5 1075.7 1081.7 1086.4 1106.1 1109.1 11451.3 11469.2 11470.3 11472.5 11477.0 4559.0 4569.3 4783.2 4790.2 4797.2 8658.5 9811.0 9817.1 9819.3 9830.6 5339.0 5350.6 5351.1 5366.0 5377.5 4872.0 4890.0 4933.2 4934.1 4963.2 3899.7 3907.5 3953.0 4022.8 4037.5 1142.3 1178.0 1227.6 1261.5 1270.6 766.2 842.7 868.1 880.5 976.7 5632.4 5769.6 5935.1 6007.6 6111.5 906.9 908.6 933.3 958.1 966.8 3945.1 3990.9 4017.9 4050.6 4074.0 10350.5 10821.3 10822.2 10832.7 10858.8 9818.5 10267.7 10622.8 10773.5 10782.0 7969.8 8286.6 8297.6 8304.8 8315.8 5937.4 5950.7 5978.4 6080.3 6246.6 9041.5 9876.6 10149.7 10153.6 10191.6 10326.3 10337.4 10347.9 10356.1 10378.8 7008.0 7059.3 7062.1 7190.0 7201.2 8164.6 8174.4 8281.2 8281.8 8281.9 7374.6 7483.1 7502.9 7555.4 7664.5 7343.8 7398.4 7418.7 7460.1 7485.5 6923.7 6973.0 7014.2 7020.6 7021.5 4907.0 4982.7 5034.5 5058.7 5111.1 5009.1 5047.7 5097.5 5103.4 5219.3 11:35:15 INFO - PROCESS | 1962 | 11:35:15 INFO - PROCESS | 1962 | [#4] prototype.html Cycles:180 Average:4367.17 Median:4744.44 stddev:1382.23 (29.1%) stddev-sans-first:1351.96 11:35:15 INFO - PROCESS | 1962 | Values: 298.8 298.9 307.6 312.9 315.5 4567.9 5117.3 5312.2 5340.3 5347.8 5084.9 5144.1 5278.8 5296.4 5301.6 3694.6 3705.5 4049.9 4054.3 4066.5 3020.4 3397.4 3809.6 4086.8 4100.2 3051.5 3167.9 3431.3 3708.5 4037.2 3390.4 3689.9 3882.3 4022.5 4058.7 3384.6 3487.4 3500.6 3516.3 3562.2 4759.5 5093.3 5149.9 5151.3 5180.7 4230.5 4490.1 4593.1 4611.5 4652.9 5547.7 5575.4 5590.5 5616.5 5627.8 3684.3 3884.7 3888.4 3913.2 3919.4 4905.0 5253.7 5465.5 5852.8 5865.4 3974.8 3978.7 3991.0 3993.5 4002.1 3650.3 3933.9 4009.1 4032.6 4040.4 3994.6 4475.7 4583.4 4585.5 4605.7 4729.4 5705.4 5717.6 5731.9 5737.7 1253.8 1287.5 1289.4 1330.5 1335.7 737.9 759.7 797.8 799.2 812.5 3852.3 4168.2 4361.6 4367.9 4382.1 4031.1 4369.8 4811.0 4818.3 4823.6 3599.9 4351.3 4365.4 4394.9 4399.0 1930.5 2299.8 2537.7 2539.7 2542.8 4394.5 4408.8 4715.0 4972.9 4993.7 4215.8 4643.9 4860.0 4882.5 4950.5 4473.9 4883.0 4918.5 5993.9 6030.2 5210.5 5401.5 5765.6 5768.3 5773.6 5522.6 5753.9 5788.2 5812.6 5824.6 5196.3 5726.2 5962.7 6007.3 6007.6 3283.6 3600.3 3876.5 3881.6 3887.9 5056.8 5261.2 5803.2 5812.9 5852.4 5148.0 5596.7 5646.4 5652.7 5667.3 4715.3 5352.0 5388.1 5620.9 5645.9 5218.5 5510.9 5517.6 5539.4 5554.6 5108.0 5211.6 5651.6 5668.4 5732.7 5060.9 5501.0 5538.3 5555.3 5584.5 11:35:15 INFO - PROCESS | 1962 | 11:35:15 INFO - PROCESS | 1962 | [#5] yui.html Cycles:180 Average:25303.45 Median:3740.98 stddev:40434.78 (1080.9%) stddev-sans-first:40506.29 11:35:15 INFO - PROCESS | 1962 | Values: 780.9 785.5 800.5 802.1 825.3 14558.2 15645.5 15658.9 15666.1 15674.3 15003.9 15704.0 15709.4 15712.9 15744.8 687.9 702.4 834.4 847.5 860.6 847.4 848.3 850.0 869.5 874.6 891.8 901.2 901.4 901.8 901.9 718.3 890.1 897.0 899.6 922.3 637.5 638.2 638.8 659.8 662.1 15167.6 15202.6 15218.5 15233.2 15261.6 12439.0 14732.7 14762.6 14795.9 14873.3 11880.5 12020.0 12056.5 12243.9 12615.6 3864.5 3921.1 3927.8 3941.6 4053.9 101678.0 103246.0 104276.5 104380.0 105713.0 10363.4 11461.5 11527.6 11567.3 11932.4 23619.4 23861.0 23867.2 23875.0 23881.3 8173.4 8195.1 8196.0 8418.1 8432.7 4475.2 4610.8 4615.0 4620.1 4715.5 3605.9 3740.3 3741.7 3744.9 3917.8 703.2 708.9 709.5 715.7 727.2 518.5 555.8 577.2 605.0 670.0 8022.5 8893.8 8907.0 9579.6 9689.8 605.0 608.4 643.4 663.9 665.9 4393.3 4575.6 4610.9 4651.7 4769.2 146824.0 147234.0 155830.0 158038.2 158193.0 132903.0 136298.0 136368.3 139686.0 140908.9 113637.0 115056.0 116276.0 116731.0 118146.0 7949.0 8991.9 9006.7 9038.1 9172.8 53672.9 55600.0 56488.5 61391.7 65920.7 87123.0 87729.6 91229.0 91973.6 94496.5 13160.4 13686.7 13809.4 13904.1 13919.0 12989.3 15051.2 15053.3 15468.6 15683.0 14063.4 14373.4 14505.8 14805.6 15008.3 13759.2 13876.6 14565.3 14648.3 14686.6 13380.9 13656.6 13694.7 14195.5 14387.9 11361.2 11411.9 11484.7 11597.4 12046.2 9673.1 10560.2 11212.9 11447.1 11788.9 11:35:15 INFO - PROCESS | 1962 | -------- Summary: end -------- 11:35:15 INFO - PROCESS | 1962 | 11:35:16 INFO - TEST-INFO | 1962: exit 0 11:35:16 INFO - TEST-OK | dromaeo_css | took 1116141ms 11:35:16 INFO - TEST-START | kraken 11:35:16 INFO - operating with platform_type : mac_ 11:35:16 INFO - Initialising browser for kraken test... 11:35:16 INFO - TEST-INFO | started process 1968 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmpuRvBEq/profile http://localhost:53259/getInfo.html) 11:35:18 INFO - PROCESS | 1968 | __metrics Screen width/height:1600/1200 11:35:18 INFO - PROCESS | 1968 | colorDepth:24 11:35:18 INFO - PROCESS | 1968 | Browser inner width/height: 1024/689 11:35:18 INFO - PROCESS | 1968 | __metrics 11:35:18 INFO - PROCESS | 1968 | 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" 11:35:18 INFO - PROCESS | 1968 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:35:19 INFO - TEST-INFO | 1968: exit 0 11:35:19 INFO - Browser initialized. 11:35:19 INFO - Running cycle 1/1 for kraken test... 11:35:19 INFO - TEST-INFO | started process 1969 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmpuRvBEq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:35:31 INFO - PROCESS | 1969 | RSS: Main: 243499008 11:35:31 INFO - PROCESS | 1969 | 11:35:34 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:53259/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53259/tests/kraken/driver.html?testName=audio-beat-detection) 11:35:34 INFO - PROCESS | 1969 | RSS: Main: 294211584 11:35:34 INFO - PROCESS | 1969 | 11:35:37 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:53259/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53259/tests/kraken/driver.html?testName=audio-dft) 11:35:38 INFO - PROCESS | 1969 | RSS: Main: 304537600 11:35:38 INFO - PROCESS | 1969 | 11:35:41 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:53259/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53259/tests/kraken/driver.html?testName=audio-fft) 11:35:42 INFO - PROCESS | 1969 | RSS: Main: 393175040 11:35:42 INFO - PROCESS | 1969 | 11:35:44 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:53259/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53259/tests/kraken/driver.html?testName=audio-oscillator) 11:35:45 INFO - PROCESS | 1969 | RSS: Main: 292179968 11:35:45 INFO - PROCESS | 1969 | 11:35:47 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:53259/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53259/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:35:47 INFO - PROCESS | 1969 | RSS: Main: 296607744 11:35:47 INFO - PROCESS | 1969 | 11:35:50 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:53259/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53259/tests/kraken/driver.html?testName=imaging-darkroom) 11:35:51 INFO - PROCESS | 1969 | RSS: Main: 334393344 11:35:51 INFO - PROCESS | 1969 | 11:35:54 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:53259/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53259/tests/kraken/driver.html?testName=imaging-desaturate) 11:35:54 INFO - PROCESS | 1969 | RSS: Main: 335695872 11:35:54 INFO - PROCESS | 1969 | 11:35:57 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:53259/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53259/tests/kraken/driver.html?testName=json-parse-financial) 11:35:58 INFO - PROCESS | 1969 | RSS: Main: 335179776 11:35:58 INFO - PROCESS | 1969 | 11:35:59 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:53259/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53259/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:36:00 INFO - PROCESS | 1969 | RSS: Main: 314249216 11:36:00 INFO - PROCESS | 1969 | 11:36:02 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:53259/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53259/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:36:02 INFO - PROCESS | 1969 | RSS: Main: 321007616 11:36:02 INFO - PROCESS | 1969 | 11:36:05 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:53259/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53259/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:36:05 INFO - PROCESS | 1969 | RSS: Main: 318656512 11:36:05 INFO - PROCESS | 1969 | 11:36:08 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:53259/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53259/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:36:09 INFO - PROCESS | 1969 | RSS: Main: 327598080 11:36:09 INFO - PROCESS | 1969 | 11:36:12 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:53259/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53259/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:36:12 INFO - PROCESS | 1969 | RSS: Main: 330031104 11:36:12 INFO - PROCESS | 1969 | 11:36:14 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:53259/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53259/tests/kraken/driver.html?testName=ai-astar) 11:36:15 INFO - PROCESS | 1969 | RSS: Main: 373153792 11:36:15 INFO - PROCESS | 1969 | 11:36:15 INFO - PROCESS | 1969 | __start_tp_report 11:36:15 INFO - PROCESS | 1969 | _x_x_mozilla_page_load 11:36:15 INFO - PROCESS | 1969 | _x_x_mozilla_page_load_details 11:36:15 INFO - PROCESS | 1969 | |i|pagename|runs| 11:36:15 INFO - PROCESS | 1969 | |0;ai-astar;99;114;116;113;118;160;160;113;112;110 11:36:15 INFO - PROCESS | 1969 | |1;audio-beat-detection;145;107;109;158;105;111;131;106;140;127 11:36:15 INFO - PROCESS | 1969 | |2;audio-dft;184;184;186;183;184;185;203;183;182;183 11:36:15 INFO - PROCESS | 1969 | |3;audio-fft;79;76;58;91;58;57;62;69;84;77 11:36:15 INFO - PROCESS | 1969 | |4;audio-oscillator;89;90;95;70;76;69;97;72;70;103 11:36:15 INFO - PROCESS | 1969 | |5;imaging-gaussian-blur;91;88;92;88;91;85;120;116;98;88 11:36:15 INFO - PROCESS | 1969 | |6;imaging-darkroom;96;97;97;97;96;96;96;96;96;95 11:36:15 INFO - PROCESS | 1969 | |7;imaging-desaturate;87;86;87;97;112;85;87;84;86;86 11:36:15 INFO - PROCESS | 1969 | |8;json-parse-financial;53;53;54;54;53;55;53;54;54;55 11:36:15 INFO - PROCESS | 1969 | |9;json-stringify-tinderbox;66;76;64;76;72;67;70;68;69;75 11:36:15 INFO - PROCESS | 1969 | |10;stanford-crypto-aes;86;81;85;84;83;81;83;83;81;85 11:36:15 INFO - PROCESS | 1969 | |11;stanford-crypto-ccm;135;129;144;145;144;142;145;131;218;138 11:36:15 INFO - PROCESS | 1969 | |12;stanford-crypto-pbkdf2;164;163;163;160;172;202;200;172;162;164 11:36:15 INFO - PROCESS | 1969 | |13;stanford-crypto-sha256-iterative;67;65;65;79;79;83;67;58;82;81 11:36:15 INFO - PROCESS | 1969 | __end_tp_report 11:36:15 INFO - PROCESS | 1969 | __start_cc_report 11:36:15 INFO - PROCESS | 1969 | _x_x_mozilla_cycle_collect,2096 11:36:15 INFO - PROCESS | 1969 | __end_cc_report 11:36:15 INFO - PROCESS | 1969 | __startTimestamp1467225374997__endTimestamp 11:36:15 INFO - PROCESS | 1969 | 11:36:15 INFO - PROCESS | 1969 | ------- Summary: start ------- 11:36:15 INFO - PROCESS | 1969 | Number of tests: 14 11:36:15 INFO - PROCESS | 1969 | 11:36:15 INFO - PROCESS | 1969 | [#0] ai-astar Cycles:10 Average:121.50 Median:117.00 stddev:20.91 (17.9%) stddev-sans-first:20.54 11:36:15 INFO - PROCESS | 1969 | Values: 99.0 114.0 116.0 113.0 118.0 160.0 160.0 113.0 112.0 110.0 11:36:15 INFO - PROCESS | 1969 | 11:36:15 INFO - PROCESS | 1969 | [#1] audio-beat-detection Cycles:10 Average:123.90 Median:129.00 stddev:19.09 (14.8%) stddev-sans-first:18.66 11:36:15 INFO - PROCESS | 1969 | Values: 145.0 107.0 109.0 158.0 105.0 111.0 131.0 106.0 140.0 127.0 11:36:15 INFO - PROCESS | 1969 | 11:36:15 INFO - PROCESS | 1969 | [#2] audio-dft Cycles:10 Average:185.70 Median:184.00 stddev:6.18 (3.4%) stddev-sans-first:6.53 11:36:15 INFO - PROCESS | 1969 | Values: 184.0 184.0 186.0 183.0 184.0 185.0 203.0 183.0 182.0 183.0 11:36:15 INFO - PROCESS | 1969 | 11:36:15 INFO - PROCESS | 1969 | [#3] audio-fft Cycles:10 Average:71.10 Median:76.50 stddev:12.08 (15.8%) stddev-sans-first:12.47 11:36:15 INFO - PROCESS | 1969 | Values: 79.0 76.0 58.0 91.0 58.0 57.0 62.0 69.0 84.0 77.0 11:36:15 INFO - PROCESS | 1969 | 11:36:15 INFO - PROCESS | 1969 | [#4] audio-oscillator Cycles:10 Average:83.10 Median:82.50 stddev:13.03 (15.8%) stddev-sans-first:13.65 11:36:15 INFO - PROCESS | 1969 | Values: 89.0 90.0 95.0 70.0 76.0 69.0 97.0 72.0 70.0 103.0 11:36:15 INFO - PROCESS | 1969 | 11:36:15 INFO - PROCESS | 1969 | [#5] imaging-gaussian-blur Cycles:10 Average:95.70 Median:89.50 stddev:12.28 (13.7%) stddev-sans-first:12.91 11:36:15 INFO - PROCESS | 1969 | Values: 91.0 88.0 92.0 88.0 91.0 85.0 120.0 116.0 98.0 88.0 11:36:15 INFO - PROCESS | 1969 | 11:36:15 INFO - PROCESS | 1969 | [#6] imaging-darkroom Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 11:36:15 INFO - PROCESS | 1969 | Values: 96.0 97.0 97.0 97.0 96.0 96.0 96.0 96.0 96.0 95.0 11:36:15 INFO - PROCESS | 1969 | 11:36:15 INFO - PROCESS | 1969 | [#7] imaging-desaturate Cycles:10 Average:89.70 Median:86.50 stddev:8.62 (10.0%) stddev-sans-first:9.08 11:36:15 INFO - PROCESS | 1969 | Values: 87.0 86.0 87.0 97.0 112.0 85.0 87.0 84.0 86.0 86.0 11:36:15 INFO - PROCESS | 1969 | 11:36:15 INFO - PROCESS | 1969 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:0.79 (1.5%) stddev-sans-first:0.78 11:36:15 INFO - PROCESS | 1969 | Values: 53.0 53.0 54.0 54.0 53.0 55.0 53.0 54.0 54.0 55.0 11:36:15 INFO - PROCESS | 1969 | 11:36:15 INFO - PROCESS | 1969 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:71.00 stddev:4.30 (6.1%) stddev-sans-first:4.27 11:36:15 INFO - PROCESS | 1969 | Values: 66.0 76.0 64.0 76.0 72.0 67.0 70.0 68.0 69.0 75.0 11:36:15 INFO - PROCESS | 1969 | 11:36:15 INFO - PROCESS | 1969 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.50 stddev:1.81 (2.2%) stddev-sans-first:1.62 11:36:15 INFO - PROCESS | 1969 | Values: 86.0 81.0 85.0 84.0 83.0 81.0 83.0 83.0 81.0 85.0 11:36:15 INFO - PROCESS | 1969 | 11:36:15 INFO - PROCESS | 1969 | [#11] stanford-crypto-ccm Cycles:10 Average:147.10 Median:144.00 stddev:25.60 (17.8%) stddev-sans-first:26.77 11:36:15 INFO - PROCESS | 1969 | Values: 135.0 129.0 144.0 145.0 144.0 142.0 145.0 131.0 218.0 138.0 11:36:15 INFO - PROCESS | 1969 | 11:36:15 INFO - PROCESS | 1969 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:168.00 stddev:15.70 (9.3%) stddev-sans-first:16.37 11:36:15 INFO - PROCESS | 1969 | Values: 164.0 163.0 163.0 160.0 172.0 202.0 200.0 172.0 162.0 164.0 11:36:15 INFO - PROCESS | 1969 | 11:36:15 INFO - PROCESS | 1969 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:79.00 stddev:9.07 (11.5%) stddev-sans-first:9.39 11:36:15 INFO - PROCESS | 1969 | Values: 67.0 65.0 65.0 79.0 79.0 83.0 67.0 58.0 82.0 81.0 11:36:15 INFO - PROCESS | 1969 | -------- Summary: end -------- 11:36:15 INFO - PROCESS | 1969 | 11:36:15 INFO - TEST-INFO | 1969: exit 0 11:36:15 INFO - TEST-OK | kraken | took 59501ms 11:36:15 INFO - SUITE-END | took 1175s 11:36:16 INFO - Completed test suite (00:19:35) 11:36:16 INFO - javascript benchmark 11:36:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3329.9500507492376, 3331.500274958756, 3345.9627515470197, 3353.463445848665, 3404.693577578019, 5616.157576363547, 5658.6038977271555, 5701.77192912283, 5736.541076713864, 5779.075347944325, 5672.035753921833, 5686.175504551848, 5782.710864456771, 5785.190073389729, 5802.506786923106, 5106.106431374513, 5132.820351287705, 5187.974060129713, 5193.766280517367, 5290.470952904717, 4533.909321813562, 5269.473052694719, 5297.629165958385, 5308.92036619451, 5324.227986941891, 5121.206213036985, 5125.333706618116, 5165.483451654804, 5194.194899790538, 5206.609504287194, 5146.7683954221775, 5160.716160611165, 5174.689518628894, 5174.818881339173, 5266.210068489719, 5131.53816156544, 5157.53582177602, 5180.989707007135, 5227.869303267411, 5250.527452529291, 5601.0, 5640.294963129609, 5746.367899531048, 5767.279090113736, 5850.736716847709, 6175.722092505848, 6190.009598464269, 6231.937680623181, 6233.470155036827, 6244.500439964837, 6269.059641053833, 6281.24625044993, 6313.863504569222, 6317.178766760292, 6347.301796802348, 5665.49010589049, 5730.226419433407, 5832.708364581754, 5833.766649334021, 5844.620099693507, 6221.720022598904, 6280.403361680633, 6290.528210384239, 6298.685065746694, 6303.873922521524, 6141.9558675025355, 6169.722362493699, 6170.876582468415, 6171.814845554551, 6191.721372538156, 6096.786612468542, 6171.13604095427, 6295.842603934847, 6298.716557754912, 6300.495960323163, 5260.237265596544, 6141.792871882774, 6168.938310616926, 6217.658028808369, 6241.843953901098, 6209.130721698965, 6272.0, 6283.937160628335, 6291.213598300213, 6300.401461861115, 4978.377702787152, 4993.650444468853, 5002.249662550574, 5007.298978143063, 5033.320501732219, 4384.364267181241, 4396.1647287016, 4485.035717320727, 4509.34614480905, 4525.162844873709, 5686.2323586315315, 5688.232088667977, 5690.260266165372, 5707.1153971134545, 5708.65748055118, 6118.162361256266, 6250.531210159256, 6257.56197066201, 6274.6548939808745, 6346.524010699216, 5683.971580142155, 5695.316562012585, 5697.917395694804, 5705.144228365778, 5712.857178570486, 5293.497117773805, 5427.131658934631, 5437.564994800407, 5438.673679579238, 5450.618456708072, 5444.50999410055, 6201.782937597252, 6224.62652240867, 6252.531060170414, 6287.528435367366, 6294.402031806971, 6301.338359472189, 6320.778772742932, 6329.841753956188, 6334.9366506334345, 6228.875422491616, 6256.624602523863, 6313.3686631336495, 6323.0, 6325.399087086719, 6072.969635151796, 6166.691665416801, 6168.753249869955, 6175.59858609189, 6193.349698281616, 6290.49676025926, 6299.622022678654, 6306.054091886071, 6321.841953951188, 6325.272593651789, 5956.434138756985, 6045.848853778691, 6051.0, 6084.574079814371, 6090.847728806638, 6109.040306147876, 6109.586862300737, 6122.306673174842, 6127.128444391353, 6127.464420129145, 5832.329282132439, 5897.0, 5963.13534537481, 5969.791057312973, 6055.0, 5813.215215945962, 6090.786822461193, 6091.1472393864005, 6101.095933926387, 6146.508279337731, 5956.076808094752, 5970.9701451492465, 5974.342822289632, 5978.581499295007, 6024.518038556817], "value": 5699.521371340093, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [462.8287533612562, 477.72530794793, 524.7323864828937, 525.9789608415662, 542.9538489228415, 29579.852100739492, 29859.70140298599, 29914.85042574784, 30018.549721754163, 40204.19591608166, 39825.601743982625, 42887.0, 42889.284428622894, 42984.0, 42989.7850510747, 9601.663941762039, 9802.803943921117, 9803.950980245088, 9813.018698130165, 9821.066998635153, 9562.474063926482, 9675.129238368545, 9676.709698709015, 9683.709488715349, 9693.854592181124, 9628.422294662309, 9701.369410988298, 9702.320837541374, 9716.0, 9721.562529686182, 9619.951900240489, 9670.70987870358, 9680.854787178198, 9690.176335011533, 9693.030696930322, 9578.281628877792, 9627.181689556395, 9650.034996500364, 9654.27592930533, 9659.90340096597, 40415.0, 40890.59109408897, 40908.0, 40933.0, 41033.0, 3340.6993370596765, 3399.6426682104375, 3954.8418063277436, 4090.6931980101613, 4292.0, 32256.677433225836, 32472.6752732472, 32525.349493010006, 32542.349153016807, 32556.02331930046, 3195.0, 3453.4301840196335, 3468.514407982884, 3469.3755124077657, 3475.600305964821, 525495.0, 525729.0, 527053.0, 527239.9999999962, 528219.9999999962, 59510.0, 59653.70173149106, 59659.70170149121, 59722.40277597255, 59841.0, 62625.11123776381, 62662.686686566274, 62703.37296627067, 62749.0, 62848.371516285166, 14114.294285285694, 15588.454404096028, 16411.507654770136, 16636.334546618, 16663.91668041652, 11663.542057242845, 11938.164328496921, 11939.343336116597, 11985.16103872738, 12648.304343261025, 15592.92203538975, 15880.920595396949, 15886.285117169755, 15916.283767230503, 15931.522054338388, 4347.345279538544, 6560.081588577603, 7056.964715176391, 7667.738017284914, 7792.740105369379, 871.311663785615, 903.7753843542038, 965.6909788867495, 970.9951450242703, 984.8128855517429, 28755.849766009545, 30405.391892162475, 31355.686443135277, 31930.0, 32337.35325293481, 1025.707673313117, 1049.9370037797758, 1081.9513121909533, 1086.1853609792656, 1131.3212072756444, 15209.315580798891, 15704.0, 15778.97436666613, 15799.0, 16087.356505739874, 674750.0, 688672.0, 694478.5276073588, 695813.0, 696369.0, 57897.42102579005, 58328.416715832296, 58351.0, 58456.0, 58572.0, 1256.0956111599633, 1381.8203633527778, 1403.0248976960913, 1415.575327401796, 1417.4684493315008, 30784.384312314076, 30792.53811192789, 31072.22319442032, 31717.68282317147, 31765.0, 43717.78141109274, 56601.43398565962, 57524.0, 57603.1359529599, 60875.12998960161, 640381.0, 642300.0, 649917.0, 650420.0, 651223.0, 35258.8237058813, 36189.457158143174, 36747.44878826766, 43709.78145109381, 45516.54483455256, 44542.88642783827, 44922.0, 45751.77124114358, 45829.54170458253, 45890.85272868205, 33070.66929330772, 37322.81338593398, 39523.011924702114, 39989.0, 40216.0, 39785.00537486586, 40060.80507106363, 40164.3975340376, 40672.79663601663, 40859.387109192794, 38282.61717382791, 38407.61592384041, 39031.02422439462, 39036.414453783786, 39040.80479597584, 33918.491222631186, 34079.48880766741, 35152.66049725272, 35168.824155879054, 35279.823600881835, 25307.114251001127, 25320.746792532576, 25469.4032497339, 25869.48261034731, 26194.0], "value": 20293.408169455844, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.86518959821274, 352.13726370392544, 376.7325199108632, 386.84719535783364, 400.867713654494, 14596.78104828427, 15648.452304169356, 20931.16275348988, 21003.94980250985, 22172.223972160937, 20914.0, 21024.789752102475, 21426.678599821014, 22032.0, 22096.88951555244, 5828.475437210661, 6051.939480605203, 6097.847553811146, 6106.755729770804, 6109.327973922865, 4166.64583510402, 4402.581754733295, 5997.280326360843, 6741.224759152711, 6743.35938085881, 5891.322497912731, 6699.296573859748, 6705.362990515918, 6706.798796036102, 6708.127943367355, 6358.713857876407, 6648.03603477493, 6656.334366563354, 6658.334166583351, 6660.467162626978, 3722.3671975764187, 3916.15802602439, 3943.921121577552, 3950.486436763202, 5719.370869204384, 25320.493590128277, 26135.0, 26249.868750656315, 26743.796529156236, 26964.325891852666, 2208.492046829222, 2233.7319521657505, 2444.0346063305074, 2579.290695058855, 2780.9443811123865, 14528.927355363156, 14992.700145997129, 15375.769363459556, 15927.96468229573, 16598.170091495496, 1791.3909270847973, 1847.9750963827296, 1854.6476169527746, 1865.4496923407492, 1876.418310323804, 111160.88839111586, 111246.44376778146, 112034.42691777236, 112902.43548782286, 113401.86598133996, 8758.605862736193, 9069.77325566866, 9978.401295922267, 10613.416262105658, 11002.614908478165, 12998.805017924738, 13033.283169425584, 13048.34758262083, 13052.282124483054, 13052.412641430969, 7563.546187228784, 7997.0, 8084.595770211584, 8144.837103257902, 8152.021757389151, 8541.572921354033, 8822.0, 8879.866801997976, 8985.685501007434, 8999.82000359989, 5686.237266447414, 6607.603543787388, 6703.698333575001, 6726.495512836557, 6797.334653010044, 1823.4165067178642, 1829.5883426228993, 1829.7529833472577, 1830.734543491213, 1847.5842935339442, 890.7372325164092, 909.1090731083575, 925.4123631493915, 957.5451660461225, 989.5695372512836, 22637.773622263896, 22824.97287622061, 22900.083996639947, 23115.422114446937, 23204.419889502897, 992.4640694025146, 1018.4042335233823, 1024.7643042100358, 1030.8093002794508, 1039.443897514826, 10560.683179504627, 11167.441627918572, 11754.294742315318, 12119.939400302943, 12156.574519891761, 541411.2929435328, 599231.0, 608269.0, 611604.0, 613252.9337353285, 113194.0, 113195.43402282936, 114805.0, 114906.0, 117613.0, 989.7278248481581, 997.8247420622967, 1005.2862467647906, 1020.6733845169623, 1022.2384323678907, 18860.52848678794, 19866.10602522861, 20132.496687582927, 20159.193632255134, 20215.29246476425, 51211.487885120674, 53378.0, 53411.4658853422, 53576.196357053894, 53600.73199633977, 61380.93095345304, 62355.0, 63244.68377658082, 73574.63212683902, 74870.87693684708, 7029.191642961125, 7736.535807851547, 7975.042994840656, 8117.431779775359, 8334.708285209988, 11097.0, 13503.59489215325, 13597.116187447784, 13736.175829450265, 13744.0, 11496.482658280565, 11563.479643415898, 11694.47374868116, 11833.644990650295, 11886.465109069939, 11310.547578096784, 11587.073034157078, 11650.126240531825, 11703.414829258674, 11759.176857619885, 11625.069994400597, 11778.469968851594, 11897.977343851393, 12100.757984840078, 12115.575954841539, 7982.201779821971, 8036.236557527026, 8088.757337279891, 8306.0, 8317.875231871647, 11684.240524366229, 11710.0, 11881.643550693492, 11902.988245999188, 11913.987311078656], "value": 9757.41403961988, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1485.064409422064, 1522.9695406091878, 1691.8984860908347, 1817.6730986379935, 1862.8882267063968, 8377.287930525905, 8636.870446943301, 8808.251298639607, 8829.779255518608, 8839.867401988975, 7750.069991601016, 8019.599020049003, 8417.410781245315, 8605.741827745162, 8653.350998675092, 2347.2371479269177, 2374.9762502375015, 2376.9881150594224, 2378.143868207444, 2378.5480758655885, 2348.3424641100432, 2362.1024010875844, 2389.0682633772844, 2393.44950661348, 2394.916177933773, 2096.4549217203485, 2174.739031316244, 2306.7231932168165, 2375.5011447596025, 2379.524095180962, 2352.023910077316, 2360.728516220631, 2380.5595964746403, 2381.8094552435764, 2395.8802059896934, 2103.747550293959, 2307.4231442139467, 2370.2415227127326, 2380.7262164850918, 2383.749706280833, 8805.987311459201, 8862.335324850663, 8873.46759194444, 8884.600192991331, 8897.822043559092, 5202.401723801773, 5300.310959575269, 5371.650842695212, 5383.246345511631, 5389.622726409153, 3581.1405262736757, 3590.4793804898404, 3648.142686468704, 3658.1220507078374, 3662.450632405134, 1075.714935542082, 1081.7133459633203, 1086.4241951765578, 1106.1372129738816, 1109.1459576126338, 11451.312921224753, 11469.197156199069, 11470.311781293149, 11472.541098356056, 11477.0, 4559.042601053749, 4569.314602809605, 4783.1868582341085, 4790.233562629963, 4797.18447863864, 8658.523781192094, 9811.018898110131, 9817.116459518678, 9819.312648114706, 9830.557624906896, 5339.0, 5350.6254562180275, 5351.09031464652, 5366.007288651612, 5377.542908852792, 4871.95128048715, 4889.951100489021, 4933.210686290176, 4934.087193869145, 4963.230699241623, 3899.6880249579967, 3907.531096268466, 3952.980235098806, 4022.8390864365097, 4037.475128233311, 1142.2746555936874, 1177.988220117805, 1227.613301809927, 1261.4512686981193, 1270.574357590199, 766.2146300042501, 842.650300125441, 868.0624925080898, 880.4849163239577, 976.6581696406344, 5632.408597097246, 5769.624974376652, 5935.0503919372695, 6007.609505382136, 6111.54163437744, 906.8685040669066, 908.6456282050005, 933.262722449271, 958.075457183821, 966.7873067925045, 3945.053187235043, 3990.920181596352, 4017.915162905999, 4050.635442810102, 4074.0, 10350.53422595985, 10821.296615719953, 10822.242443028912, 10832.72918177036, 10858.837117443245, 9818.459984700767, 10267.689769801884, 10622.840657390145, 10773.461326933779, 10782.0, 7969.840603187904, 8286.627101780434, 8297.58512074394, 8304.792380190424, 8315.792105197297, 5937.376575459687, 5950.672713000653, 5978.432048955342, 6080.270367555921, 6246.562740608114, 9041.547922603975, 9876.555555000186, 10149.695509134737, 10153.593856245667, 10191.643292484727, 10326.328788628714, 10337.4314412705, 10347.896521034994, 10356.119729822749, 10378.844317335095, 7008.0, 7059.329363710644, 7062.117235345582, 7189.964050179716, 7201.171865235565, 8164.5917704115745, 8174.427790054639, 8281.17188281167, 8281.83436331282, 8281.917180828355, 7374.594397308199, 7483.064616922885, 7502.924970750222, 7555.357794587521, 7664.540127592362, 7343.77968660941, 7398.408127349691, 7418.703251869865, 7460.142083660448, 7485.47601667878, 6923.688434020582, 6973.0, 7014.158301003708, 7020.5787652741, 7021.508494405547, 4907.0, 4982.701037937735, 5034.496550344937, 5058.721770302669, 5111.080005599028, 5009.123403404316, 5047.671901326402, 5097.515736005073, 5103.43862175153, 5219.347581552306], "value": 4589.434218254506, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.82668052529533, 298.8655105202659, 307.621625400757, 312.89205224197656, 315.5345864849349, 4567.862964111077, 5117.334746482952, 5312.203169524573, 5340.252364668944, 5347.786088556462, 5084.923726144101, 5144.0740666679985, 5278.841634750964, 5296.364436267643, 5301.575873930086, 3694.612065733086, 3705.5368078990127, 4049.914294138521, 4054.2904991626497, 4066.5120185577625, 3020.426119037387, 3397.3884700753856, 3809.619038096182, 4086.7547947123267, 4100.17996400721, 3051.5117581187014, 3167.8891238806646, 3431.330890476358, 3708.5165933626495, 4037.212743515001, 3390.3727810354917, 3689.907752306187, 3882.320593896057, 4022.45696830927, 4058.6753059755442, 3384.5938487381673, 3487.354839354702, 3500.597431295408, 3516.314318707853, 3562.2163124112653, 4759.5002524734755, 5093.319204662453, 5149.9485005149845, 5151.278820965068, 5180.740962951875, 4230.492340919079, 4490.124425736983, 4593.058423023273, 4611.4696809866955, 4652.906941861178, 5547.669978608954, 5575.414581468928, 5590.496855283044, 5616.466435688603, 5627.831165065055, 3684.3254834994445, 3884.7280690351686, 3888.4361767543833, 3913.2173565287057, 3919.3533067043904, 4904.975475122637, 5253.737313134367, 5465.480779325958, 5852.76588936442, 5865.384134665884, 3974.7813870237414, 3978.7214894957656, 3990.980045099756, 3993.5407428145554, 4002.0595160137345, 3650.324689932371, 3933.8819835404984, 4009.0956795522475, 4032.5765794591143, 4040.4141399496907, 3994.6032380571423, 4475.672650221932, 4583.358329833826, 4585.541445855454, 4605.723656580616, 4729.385179926588, 5705.375527257508, 5717.628354156966, 5731.914021289684, 5737.684427356452, 1253.7743206222785, 1287.4528325461642, 1289.3553223388305, 1330.4545136493991, 1335.6594068512468, 737.9335859772647, 759.6581538307784, 797.8284668796236, 799.192815256595, 812.5124925044926, 3852.287326844487, 4168.249715051259, 4361.607455328972, 4367.912641747211, 4382.05785756064, 4031.07285324377, 4369.80335884886, 4810.95189048105, 4818.301346304836, 4823.588205897052, 3599.874004409833, 4351.303791393362, 4365.410669559632, 4394.879305777006, 4398.956010439919, 1930.4787707318944, 2299.792608880351, 2537.7438168106905, 2539.6698429204084, 2542.834715743471, 4394.450693663292, 4408.823647054082, 4715.009847931973, 4972.8756781080765, 4993.725345105981, 4215.831366745358, 4643.931895664016, 4860.007396967227, 4882.461120217538, 4950.480199579064, 4473.865784026484, 4882.9755851221225, 4918.458969513351, 5993.910091348546, 6030.216071910536, 5210.505002024802, 5401.540869026019, 5765.625234359753, 5768.307803063659, 5773.624714393551, 5522.5858060644805, 5753.856153596026, 5788.247527821356, 5812.622179558315, 5824.592278540462, 5196.32447781786, 5726.226959360433, 5962.718015626661, 6007.339192688888, 6007.609505382136, 3283.589551306087, 3600.2979419014086, 3876.476675648751, 3881.573026967088, 3887.8639247626197, 5056.7724452399, 5261.184516399964, 5803.245578074992, 5812.883742325214, 5852.385499522489, 5147.962702005834, 5596.720163991703, 5646.35066967304, 5652.745626446737, 5667.319921609268, 4715.339852420595, 5352.0, 5388.110961691277, 5620.943790562042, 5645.858853528694, 5218.530332270114, 5510.9448905510435, 5517.613767036269, 5539.446055394428, 5554.583406244467, 5107.9528696617845, 5211.557017653542, 5651.6043876928225, 5668.433156684298, 5732.742026608729, 5060.898782024413, 5500.972495137498, 5538.280023597068, 5555.250041244381, 5584.46947539983], "value": 3926.0261582907033, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [780.8711562592173, 785.4541093939711, 800.4716886854677, 802.113664400837, 825.3273582030645, 14558.199299038548, 15645.530634080968, 15658.92170539147, 15666.138362390078, 15674.294656740445, 15003.924980375083, 15704.0, 15709.371625135009, 15712.921435392807, 15744.763828542582, 687.9036934829128, 702.3538344722841, 834.4200780457585, 847.4533925617973, 860.5955201055494, 847.4152834544176, 848.2959143910571, 849.9830003399928, 869.5478351257342, 874.6107981948036, 891.7859713668705, 901.2204443156655, 901.3645380007111, 901.7970956534792, 901.8602116671926, 718.335539625844, 890.0876601483532, 896.9910300896972, 899.5547204133962, 922.3128769067088, 637.4517914593446, 638.2118084166051, 638.7764282501134, 659.7558903205845, 662.1491383572135, 15167.62080947974, 15202.619934501616, 15218.543443696706, 15233.238338083162, 15261.61845953849, 12439.0, 14732.70534589313, 14762.557123286319, 14795.852041479555, 14873.256337183206, 11880.465379057963, 12020.0, 12056.457459414347, 12243.877561224363, 12615.558455454015, 3864.516935383077, 3921.0785465415606, 3927.8036098194975, 3941.6452519273116, 4053.8783836484954, 101678.0, 103246.0, 104276.47861760718, 104380.0, 105713.0, 10363.378197308035, 11461.54153833854, 11527.596534121265, 11567.305961642329, 11932.403379830974, 23619.40951476227, 23861.0, 23867.16464923754, 23875.04499819988, 23881.283561493183, 8173.386995975206, 8195.139510351446, 8195.95902020486, 8418.074011858691, 8432.662693492191, 4475.239209334421, 4610.838620648261, 4615.0, 4620.0990806793025, 4715.475450590428, 3605.85576576934, 3740.270647223765, 3741.6819570336284, 3744.857818365425, 3917.8236979335998, 703.2018658822171, 708.8582283543312, 709.4785332780402, 715.6886754261913, 727.1964479250457, 518.5048278893647, 555.7749111609804, 577.2409281794427, 604.9546284028715, 669.9631520266432, 8022.518648881086, 8893.799337089411, 8906.955465222632, 9579.616815327448, 9689.757756056155, 605.0146790446775, 608.3581821178699, 643.4016364780799, 663.8937769956784, 665.9001149827468, 4393.275109606943, 4575.58819706228, 4610.884727881763, 4651.744154071558, 4769.236922092448, 146824.0, 147234.0, 155830.0, 158038.20980895023, 158193.0, 132903.0, 136298.0, 136368.31815840857, 139686.0, 140908.8863667046, 113637.0, 115055.99999999833, 116276.0, 116731.0, 118146.0, 7948.960255198687, 8991.865122023306, 9006.684766033157, 9038.09619038091, 9172.770680732769, 53672.92654146974, 55600.0, 56488.4580193884, 61391.693041534505, 65920.6703966477, 87123.0, 87729.56135219283, 91229.0, 91973.62039569278, 94496.52751736197, 13160.407781649657, 13686.726265474435, 13809.447622095004, 13904.115721718537, 13919.0, 12989.28558929268, 15051.247437628293, 15053.250912340458, 15468.613284667974, 15683.0, 14063.437462501795, 14373.353199106274, 14505.78241326402, 14805.555833325017, 15008.324625391666, 13759.17444953306, 13876.58370248894, 14565.27173641335, 14648.340824662702, 14686.632834178803, 13380.866191337962, 13656.590302290948, 13694.65763355924, 14195.503157389441, 14387.856121438652, 11361.1514223804, 11411.885881141083, 11484.712882178012, 11597.420128993685, 12046.156769026435, 9673.114417395522, 10560.207984401048, 11212.943935280271, 11447.141464390037, 11788.941055294668], "value": 7950.956003740206, "unit": "score"}], "name": "dromaeo_css", "value": 7381.049564469074, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 114.0, 116.0, 113.0, 118.0, 160.0, 160.0, 113.0, 112.0, 110.0], "value": 121.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 107.0, 109.0, 158.0, 105.0, 111.0, 131.0, 106.0, 140.0, 127.0], "value": 123.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 186.0, 183.0, 184.0, 185.0, 203.0, 183.0, 182.0, 183.0], "value": 185.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 58.0, 91.0, 58.0, 57.0, 62.0, 69.0, 84.0, 77.0], "value": 71.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 95.0, 70.0, 76.0, 69.0, 97.0, 72.0, 70.0, 103.0], "value": 83.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 92.0, 88.0, 91.0, 85.0, 120.0, 116.0, 98.0, 88.0], "value": 95.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 87.0, 97.0, 112.0, 85.0, 87.0, 84.0, 86.0, 86.0], "value": 89.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 54.0, 53.0, 55.0, 53.0, 54.0, 54.0, 55.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 76.0, 64.0, 76.0, 72.0, 67.0, 70.0, 68.0, 69.0, 75.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 81.0, 85.0, 84.0, 83.0, 81.0, 83.0, 83.0, 81.0, 85.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 129.0, 144.0, 145.0, 144.0, 142.0, 145.0, 131.0, 218.0, 138.0], "value": 147.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 160.0, 172.0, 202.0, 200.0, 172.0, 162.0, 164.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 79.0, 79.0, 83.0, 67.0, 58.0, 82.0, 81.0], "value": 72.6, "unit": "score"}], "name": "kraken", "value": 1466.1, "alertThreshold": 2.0}]} 11:36:16 INFO - Return code: 0 11:36:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:36:16 INFO - # TBPL SUCCESS # 11:36:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:36:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:36:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:36:16 INFO - 2016-06-29 11:36:16.284 screenresolution[1973:20017] starting screenresolution argv=screenresolution get 11:36:16 INFO - 2016-06-29 11:36:16.287 screenresolution[1973:20017] Display 0: 1600x1200x32@60 11:36:16 INFO - 2016-06-29 11:36:16.293 screenresolution[1974:20020] starting screenresolution argv=screenresolution list 11:36:16 INFO - Available Modes on Display 0 11:36:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:36:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:36:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:36:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:36:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:36:16 INFO - Intel Iris: 11:36:16 INFO - Chipset Model: Intel Iris 11:36:16 INFO - Type: GPU 11:36:16 INFO - Bus: Built-In 11:36:16 INFO - VRAM (Dynamic, Max): 1536 MB 11:36:16 INFO - Vendor: Intel (0x8086) 11:36:16 INFO - Device ID: 0x0a2e 11:36:16 INFO - Revision ID: 0x0009 11:36:16 INFO - Displays: 11:36:16 INFO - Display: 11:36:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:36:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:36:16 INFO - Display Serial Number: 1600x1200 60 11:36:16 INFO - Main Display: Yes 11:36:16 INFO - Mirror: Off 11:36:16 INFO - Online: Yes 11:36:16 INFO - Rotation: Supported 11:36:16 INFO - Return code: 0 11:36:16 INFO - Running post-action listener: _resource_record_post_action 11:36:16 INFO - ##### 11:36:16 INFO - ##### Finished run-tests step (success) 11:36:16 INFO - ##### 11:36:16 INFO - Running post-run listener: _resource_record_post_run 11:36:16 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 831488; Write bytes: 702084096; Read time: 14; Write time: 1794 11:36:16 INFO - TinderboxPrint: CPU usage
53.5% 11:36:16 INFO - TinderboxPrint: I/O read bytes / time
831,488 / 14 11:36:16 INFO - TinderboxPrint: I/O write bytes / time
702,084,096 / 1,794 11:36:16 INFO - TinderboxPrint: CPU idle
2,251.9 (46.5%) 11:36:16 INFO - TinderboxPrint: CPU system
967.1 (20.0%) 11:36:16 INFO - TinderboxPrint: CPU user
1,626.7 (33.6%) 11:36:16 INFO - TinderboxPrint: Swap in / out
408,137,728 / 0 11:36:16 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 402463232; Write bytes: 397394432; Read time: 30432; Write time: 697 11:36:16 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 794624; Write bytes: 290877952; Read time: 14; Write time: 1062 11:36:16 INFO - Running post-run listener: _upload_blobber_files 11:36:16 INFO - Blob upload gear active. 11:36:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:36:16 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 11:36:16 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:36:16 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:36:17 INFO - (blobuploader) - INFO - Open directory for files ... 11:36:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:36:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:36:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:18 INFO - (blobuploader) - INFO - Done attempting. 11:36:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:36:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:36:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:18 INFO - (blobuploader) - INFO - Done attempting. 11:36:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:36:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:36:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:21 INFO - (blobuploader) - INFO - Done attempting. 11:36:21 INFO - (blobuploader) - INFO - Iteration through files over. 11:36:21 INFO - Return code: 0 11:36:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:36:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:36:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/17d30c006282787c14f0480dd7d683f0505e04961e8874951502fb123bdd7a146857ec25a19cdf5dbc0d1548ebcc0c48c2e6cd2062a647ae6676cb20c3e986b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d58fc5d98678ff736f63cd7b189375ae7b90b0a84430475e2b9a6fabda2086c63dc1707815890b6b66d0cba400006a191604a9cb58ab68d51092c8b916a2c8f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/93676c8f05964aca2d82a68ebad78204cdad04c2a40bf36ee0eaf2689d5b5468fbc8755c0e8a04b4d3aa8bf615f30a7def459227809ed0e723b3c029288620e7"} 11:36:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:36:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:36:21 INFO - Contents: 11:36:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/17d30c006282787c14f0480dd7d683f0505e04961e8874951502fb123bdd7a146857ec25a19cdf5dbc0d1548ebcc0c48c2e6cd2062a647ae6676cb20c3e986b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d58fc5d98678ff736f63cd7b189375ae7b90b0a84430475e2b9a6fabda2086c63dc1707815890b6b66d0cba400006a191604a9cb58ab68d51092c8b916a2c8f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/93676c8f05964aca2d82a68ebad78204cdad04c2a40bf36ee0eaf2689d5b5468fbc8755c0e8a04b4d3aa8bf615f30a7def459227809ed0e723b3c029288620e7"} 11:36:21 INFO - Running post-run listener: copy_logs_to_upload_dir 11:36:21 INFO - Copying logs to upload dir... 11:36:21 INFO - mkdir: /builds/slave/test/build/upload/logs 11:36:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.762604 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-06-29 11:36:21.650411) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 11:36:21.653649) ========= 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.3Haw4K7foI/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.vZzXE4SEUQ/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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/Fx-Team/sha512/17d30c006282787c14f0480dd7d683f0505e04961e8874951502fb123bdd7a146857ec25a19cdf5dbc0d1548ebcc0c48c2e6cd2062a647ae6676cb20c3e986b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d58fc5d98678ff736f63cd7b189375ae7b90b0a84430475e2b9a6fabda2086c63dc1707815890b6b66d0cba400006a191604a9cb58ab68d51092c8b916a2c8f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/93676c8f05964aca2d82a68ebad78204cdad04c2a40bf36ee0eaf2689d5b5468fbc8755c0e8a04b4d3aa8bf615f30a7def459227809ed0e723b3c029288620e7"} build_url:https://queue.taskcluster.net/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011096 build_url: 'https://queue.taskcluster.net/v1/task/PTtalymqR6SdZVdd_f4fbA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/17d30c006282787c14f0480dd7d683f0505e04961e8874951502fb123bdd7a146857ec25a19cdf5dbc0d1548ebcc0c48c2e6cd2062a647ae6676cb20c3e986b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d58fc5d98678ff736f63cd7b189375ae7b90b0a84430475e2b9a6fabda2086c63dc1707815890b6b66d0cba400006a191604a9cb58ab68d51092c8b916a2c8f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/93676c8f05964aca2d82a68ebad78204cdad04c2a40bf36ee0eaf2689d5b5468fbc8755c0e8a04b4d3aa8bf615f30a7def459227809ed0e723b3c029288620e7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 11:36:21.686512) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:36:21.686841) ========= 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.3Haw4K7foI/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.vZzXE4SEUQ/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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.005224 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:36:21.735100) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 11:36:21.735444) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 11:36:21.735765) ========= ========= Total master_lag: 0.18 =========