builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0102 starttime: 1470476278.04 results: success (0) buildid: 20160805234720 builduid: bd1e2d1a71c744099ebe26d9a2d9569c revision: 115ec609a6bf1bbc3e06f7cd2caa99e53b51e5d1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-06 02:37:58.045179) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-06 02:37:58.045975) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-06 02:37:58.046514) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-06 02:37:58.077531) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 02:37:58.078247) ========= 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.JoELRjERbo/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.BThm17ybZr/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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-08-06 02:37:58-- 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% 55.9M=0s 2016-08-06 02:37:58 (55.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179425 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 02:37:58.289577) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 02:37:58.290455) ========= 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.JoELRjERbo/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.BThm17ybZr/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.027831 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 02:37:58.350366) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 02:37:58.351100) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 115ec609a6bf1bbc3e06f7cd2caa99e53b51e5d1 --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 115ec609a6bf1bbc3e06f7cd2caa99e53b51e5d1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JoELRjERbo/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.BThm17ybZr/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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-08-06 02:37:58,429 truncating revision to first 12 chars 2016-08-06 02:37:58,429 Setting DEBUG logging. 2016-08-06 02:37:58,429 attempt 1/10 2016-08-06 02:37:58,429 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/115ec609a6bf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-06 02:37:58,829 unpacking tar archive at: fx-team-115ec609a6bf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.678868 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 02:37:59.109885) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-06 02:37:59.110250) ========= script_repo_revision: 115ec609a6bf1bbc3e06f7cd2caa99e53b51e5d1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-06 02:37:59.110693) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-06 02:37:59.111131) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-06 02:37:59.297177) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-08-06 02:37:59.298027) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.JoELRjERbo/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.BThm17ybZr/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 02:37:59 INFO - MultiFileLogger online at 20160806 02:37:59 in /builds/slave/test 02:37:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:37:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:37:59 INFO - {'append_to_log': False, 02:37:59 INFO - 'base_work_dir': '/builds/slave/test', 02:37:59 INFO - 'blob_upload_branch': 'Fx-Team', 02:37:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:37:59 INFO - 'branch': 'Fx-Team', 02:37:59 INFO - 'buildbot_json_path': 'buildprops.json', 02:37:59 INFO - 'config_files': ('talos/mac_config.py',), 02:37:59 INFO - 'default_actions': ('clobber', 02:37:59 INFO - 'read-buildbot-config', 02:37:59 INFO - 'download-and-extract', 02:37:59 INFO - 'populate-webroot', 02:37:59 INFO - 'create-virtualenv', 02:37:59 INFO - 'install', 02:37:59 INFO - 'run-tests'), 02:37:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:37:59 INFO - 'download_minidump_stackwalk': True, 02:37:59 INFO - 'download_symbols': 'ondemand', 02:37:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:37:59 INFO - 'tooltool.py': '/tools/tooltool.py', 02:37:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:37:59 INFO - '/tools/misc-python/virtualenv.py')}, 02:37:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:37:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:37:59 INFO - 'installer_path': 'installer.exe', 02:37:59 INFO - 'log_level': 'info', 02:37:59 INFO - 'log_name': 'talos', 02:37:59 INFO - 'log_to_console': True, 02:37:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:37:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:37:59 INFO - 'opt_config_files': (), 02:37:59 INFO - 'pip_index': False, 02:37:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:37:59 INFO - 'cmd': ('bash', 02:37:59 INFO - '-c', 02:37:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:37:59 INFO - 'enabled': True, 02:37:59 INFO - 'halt_on_failure': False, 02:37:59 INFO - 'name': 'check_screen_resolution'},), 02:37:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:37:59 INFO - 'cmd': ('bash', 02:37:59 INFO - '-c', 02:37:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:37:59 INFO - 'enabled': True, 02:37:59 INFO - 'halt_on_failure': False, 02:37:59 INFO - 'name': 'check_screen_resolution'},), 02:37:59 INFO - 'run_cmd_checks_enabled': True, 02:37:59 INFO - 'sps_profile': False, 02:37:59 INFO - 'sps_profile_interval': 0, 02:37:59 INFO - 'suite': 'dromaeojs-e10s', 02:37:59 INFO - 'system_bits': '32', 02:37:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:37:59 INFO - 'title': 't-yosemite-r7-0102', 02:37:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:37:59 INFO - 'use_talos_json': True, 02:37:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:37:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:37:59 INFO - 'work_dir': 'build'} 02:37:59 INFO - [mozharness: 2016-08-06 09:37:59.500543Z] Running clobber step. 02:37:59 INFO - Running pre-action listener: _resource_record_pre_action 02:37:59 INFO - Running main action method: clobber 02:37:59 INFO - rmtree: /builds/slave/test/build 02:37:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:38:00 INFO - Running post-action listener: _resource_record_post_action 02:38:00 INFO - [mozharness: 2016-08-06 09:38:00.735308Z] Finished clobber step (success) 02:38:00 INFO - [mozharness: 2016-08-06 09:38:00.735432Z] Running read-buildbot-config step. 02:38:00 INFO - Running pre-action listener: _resource_record_pre_action 02:38:00 INFO - Running main action method: read_buildbot_config 02:38:00 INFO - Using buildbot properties: 02:38:00 INFO - { 02:38:00 INFO - "project": "", 02:38:00 INFO - "product": "firefox", 02:38:00 INFO - "script_repo_revision": "production", 02:38:00 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 02:38:00 INFO - "repository": "", 02:38:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 02:38:00 INFO - "buildid": "20160805234720", 02:38:00 INFO - "pgo_build": "False", 02:38:00 INFO - "basedir": "/builds/slave/test", 02:38:00 INFO - "buildnumber": 79, 02:38:00 INFO - "slavename": "t-yosemite-r7-0102", 02:38:00 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 02:38:00 INFO - "platform": "yosemite_r7", 02:38:00 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 02:38:00 INFO - "branch": "fx-team", 02:38:00 INFO - "repo_path": "integration/fx-team", 02:38:00 INFO - "revision": "115ec609a6bf1bbc3e06f7cd2caa99e53b51e5d1", 02:38:00 INFO - "stage_platform": "macosx64", 02:38:00 INFO - "builduid": "bd1e2d1a71c744099ebe26d9a2d9569c", 02:38:00 INFO - "slavebuilddir": "test" 02:38:00 INFO - } 02:38:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/HrEATJ_oSOuhs3VuUkSrXg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 02:38:00 INFO - Running post-action listener: _resource_record_post_action 02:38:00 INFO - [mozharness: 2016-08-06 09:38:00.738501Z] Finished read-buildbot-config step (success) 02:38:00 INFO - [mozharness: 2016-08-06 09:38:00.738604Z] Running download-and-extract step. 02:38:00 INFO - Running pre-action listener: _resource_record_pre_action 02:38:00 INFO - Running main action method: download_and_extract 02:38:00 INFO - mkdir: /builds/slave/test/build/tests 02:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:00 INFO - trying https://queue.taskcluster.net/v1/task/HrEATJ_oSOuhs3VuUkSrXg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 02:38:00 INFO - Downloading https://queue.taskcluster.net/v1/task/HrEATJ_oSOuhs3VuUkSrXg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 02:38:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HrEATJ_oSOuhs3VuUkSrXg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 02:38:01 INFO - Downloaded 1199 bytes. 02:38:01 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 02:38:01 INFO - Using the following test package requirements: 02:38:01 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 02:38:01 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:38:01 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 02:38:01 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:38:01 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 02:38:01 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:38:01 INFO - u'jsshell-mac.zip'], 02:38:01 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:38:01 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 02:38:01 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 02:38:01 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:38:01 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 02:38:01 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:38:01 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 02:38:01 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:38:01 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 02:38:01 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:38:01 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 02:38:01 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:38:01 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:01 INFO - trying https://queue.taskcluster.net/v1/task/HrEATJ_oSOuhs3VuUkSrXg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 02:38:01 INFO - Downloading https://queue.taskcluster.net/v1/task/HrEATJ_oSOuhs3VuUkSrXg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 02:38:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HrEATJ_oSOuhs3VuUkSrXg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:38:03 INFO - Downloaded 16320480 bytes. 02:38:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:38:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:38:06 INFO - Return code: 0 02:38:06 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 02:38:06 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:06 INFO - trying https://queue.taskcluster.net/v1/task/HrEATJ_oSOuhs3VuUkSrXg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 02:38:06 INFO - Downloading https://queue.taskcluster.net/v1/task/HrEATJ_oSOuhs3VuUkSrXg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 02:38:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HrEATJ_oSOuhs3VuUkSrXg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:38:07 INFO - Downloaded 16320480 bytes. 02:38:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:38:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:38:11 INFO - Return code: 0 02:38:11 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:11 INFO - trying https://queue.taskcluster.net/v1/task/HrEATJ_oSOuhs3VuUkSrXg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 02:38:11 INFO - Downloading https://queue.taskcluster.net/v1/task/HrEATJ_oSOuhs3VuUkSrXg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 02:38:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HrEATJ_oSOuhs3VuUkSrXg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 02:38:12 INFO - Downloaded 14413723 bytes. 02:38:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:38:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 02:38:12 INFO - Return code: 0 02:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:12 INFO - trying https://queue.taskcluster.net/v1/task/HrEATJ_oSOuhs3VuUkSrXg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 02:38:12 INFO - Downloading https://queue.taskcluster.net/v1/task/HrEATJ_oSOuhs3VuUkSrXg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 02:38:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HrEATJ_oSOuhs3VuUkSrXg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 02:38:19 INFO - Downloaded 111815306 bytes. 02:38:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HrEATJ_oSOuhs3VuUkSrXg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 02:38:19 INFO - mkdir: /builds/slave/test/properties 02:38:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:38:19 INFO - Writing to file /builds/slave/test/properties/build_url 02:38:19 INFO - Contents: 02:38:19 INFO - build_url:https://queue.taskcluster.net/v1/task/HrEATJ_oSOuhs3VuUkSrXg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 02:38:20 INFO - Running post-action listener: _resource_record_post_action 02:38:20 INFO - Running post-action listener: set_extra_try_arguments 02:38:20 INFO - [mozharness: 2016-08-06 09:38:20.451490Z] Finished download-and-extract step (success) 02:38:20 INFO - [mozharness: 2016-08-06 09:38:20.451645Z] Running populate-webroot step. 02:38:20 INFO - Running pre-action listener: _resource_record_pre_action 02:38:20 INFO - Running main action method: populate_webroot 02:38:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:38:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:38:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:38:20 INFO - '--tppagecycles', 02:38:20 INFO - '7'], 02:38:20 INFO - 'tests': ['tsvgm']}}, 02:38:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:38:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:38:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:38:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:38:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:38:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:38:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:20 INFO - 'talos_options': ['--disable-e10s'], 02:38:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:38:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:38:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:20 INFO - 'talos_options': ['--disable-e10s'], 02:38:20 INFO - 'tests': ['damp', 'tps']}, 02:38:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:20 INFO - 'tests': ['damp', 'tps']}, 02:38:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:38:20 INFO - 'tests': ['dromaeo_dom']}, 02:38:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:38:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:38:20 INFO - 'tests': ['basic_compositor_video']}, 02:38:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:38:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:38:20 INFO - 'tests': ['a11yr', 02:38:20 INFO - 'ts_paint', 02:38:20 INFO - 'tpaint', 02:38:20 INFO - 'sessionrestore', 02:38:20 INFO - 'sessionrestore_no_auto_restore', 02:38:20 INFO - 'tabpaint']}, 02:38:20 INFO - 'other-e10s': {'tests': ['a11yr', 02:38:20 INFO - 'ts_paint', 02:38:20 INFO - 'tpaint', 02:38:20 INFO - 'sessionrestore', 02:38:20 INFO - 'sessionrestore_no_auto_restore', 02:38:20 INFO - 'tabpaint']}, 02:38:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:38:20 INFO - 'ts_paint', 02:38:20 INFO - 'tpaint', 02:38:20 INFO - 'sessionrestore', 02:38:20 INFO - 'sessionrestore_no_auto_restore', 02:38:20 INFO - 'tabpaint']}, 02:38:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:38:20 INFO - 'ts_paint', 02:38:20 INFO - 'tpaint', 02:38:20 INFO - 'sessionrestore', 02:38:20 INFO - 'sessionrestore_no_auto_restore', 02:38:20 INFO - 'tabpaint']}, 02:38:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:38:20 INFO - 'tests': ['a11yr', 02:38:20 INFO - 'ts_paint', 02:38:20 INFO - 'tpaint', 02:38:20 INFO - 'sessionrestore', 02:38:20 INFO - 'sessionrestore_no_auto_restore', 02:38:20 INFO - 'tabpaint']}, 02:38:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:38:20 INFO - 'tests': ['a11yr', 02:38:20 INFO - 'ts_paint', 02:38:20 INFO - 'tpaint', 02:38:20 INFO - 'sessionrestore', 02:38:20 INFO - 'sessionrestore_no_auto_restore', 02:38:20 INFO - 'tabpaint']}, 02:38:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:38:20 INFO - 'tests': ['tsvgx', 02:38:20 INFO - 'tsvgr_opacity', 02:38:20 INFO - 'tart', 02:38:20 INFO - 'tscrollx', 02:38:20 INFO - 'cart']}, 02:38:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:38:20 INFO - 'tsvgr_opacity', 02:38:20 INFO - 'tart', 02:38:20 INFO - 'tscrollx', 02:38:20 INFO - 'cart']}, 02:38:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:20 INFO - 'talos_options': ['--disable-e10s'], 02:38:20 INFO - 'tests': ['tp5o']}, 02:38:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:20 INFO - 'tests': ['tp5o']}, 02:38:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:20 INFO - 'talos_options': ['--disable-e10s', 02:38:20 INFO - '--xperf_path', 02:38:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:38:20 INFO - 'tests': ['tp5n']}, 02:38:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:38:20 INFO - 'talos_options': ['--xperf_path', 02:38:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:38:20 INFO - 'tests': ['tp5n']}}, 02:38:20 INFO - 'talos.zip': {'path': '', 02:38:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:38:20 INFO - Running post-action listener: _resource_record_post_action 02:38:20 INFO - [mozharness: 2016-08-06 09:38:20.470122Z] Finished populate-webroot step (success) 02:38:20 INFO - [mozharness: 2016-08-06 09:38:20.470230Z] Running create-virtualenv step. 02:38:20 INFO - Running pre-action listener: _resource_record_pre_action 02:38:20 INFO - Running main action method: create_virtualenv 02:38:20 INFO - Creating virtualenv /builds/slave/test/build/venv 02:38:20 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 02:38:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:38:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:38:20 INFO - Using real prefix '/tools/python27' 02:38:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:38:21 INFO - Installing distribute.............................................................................................................................................................................................done. 02:38:24 INFO - Installing pip.................done. 02:38:24 INFO - Return code: 0 02:38:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:24 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 0x109e34a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ec9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0a056c820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d98d30>, '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 0x109afddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d90b20>, '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.JoELRjERbo/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.BThm17ybZr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 02:38:24 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 02:38:24 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 02:38:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JoELRjERbo/Render', 02:38:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:38:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:38:24 INFO - 'HOME': '/Users/cltbld', 02:38:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:38:24 INFO - 'LOGNAME': 'cltbld', 02:38:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:24 INFO - 'MOZ_NO_REMOTE': '1', 02:38:24 INFO - 'NO_EM_RESTART': '1', 02:38:24 INFO - 'PAGER': '/bin/cat', 02:38:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:38:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:24 INFO - 'PWD': '/builds/slave/test', 02:38:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:38:24 INFO - 'SHELL': '/bin/bash', 02:38:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BThm17ybZr/Listeners', 02:38:24 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 02:38:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:38:24 INFO - 'USER': 'cltbld', 02:38:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:38:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:38:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:24 INFO - 'XPC_FLAGS': '0x0', 02:38:24 INFO - 'XPC_SERVICE_NAME': '0', 02:38:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:38:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:24 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 02:38:24 INFO - Cleaning up... 02:38:24 INFO - Return code: 0 02:38:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:24 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 0x109e34a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ec9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0a056c820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d98d30>, '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 0x109afddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d90b20>, '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.JoELRjERbo/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.BThm17ybZr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 02:38:24 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 02:38:24 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 02:38:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JoELRjERbo/Render', 02:38:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:38:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:38:24 INFO - 'HOME': '/Users/cltbld', 02:38:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:38:24 INFO - 'LOGNAME': 'cltbld', 02:38:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:24 INFO - 'MOZ_NO_REMOTE': '1', 02:38:24 INFO - 'NO_EM_RESTART': '1', 02:38:24 INFO - 'PAGER': '/bin/cat', 02:38:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:38:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:24 INFO - 'PWD': '/builds/slave/test', 02:38:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:38:24 INFO - 'SHELL': '/bin/bash', 02:38:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BThm17ybZr/Listeners', 02:38:24 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 02:38:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:38:24 INFO - 'USER': 'cltbld', 02:38:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:38:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:38:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:24 INFO - 'XPC_FLAGS': '0x0', 02:38:24 INFO - 'XPC_SERVICE_NAME': '0', 02:38:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:38:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:24 INFO - Downloading/unpacking psutil>=3.1.1 02:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:38:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:38:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:38:27 INFO - Installing collected packages: psutil 02:38:27 INFO - Running setup.py install for psutil 02:38:27 INFO - building 'psutil._psutil_osx' extension 02:38:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:38:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:38:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:38:28 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 02:38:28 INFO - building 'psutil._psutil_posix' extension 02:38:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:38:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:38:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:38:28 INFO - ^ 02:38:28 INFO - 1 warning generated. 02:38:28 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:38:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:38:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:38:28 INFO - Successfully installed psutil 02:38:28 INFO - Cleaning up... 02:38:29 INFO - Return code: 0 02:38:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:38:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e34a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ec9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0a056c820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d98d30>, '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 0x109afddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d90b20>, '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.JoELRjERbo/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.BThm17ybZr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 02:38:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:38:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:38:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JoELRjERbo/Render', 02:38:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:38:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:38:29 INFO - 'HOME': '/Users/cltbld', 02:38:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:38:29 INFO - 'LOGNAME': 'cltbld', 02:38:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:29 INFO - 'MOZ_NO_REMOTE': '1', 02:38:29 INFO - 'NO_EM_RESTART': '1', 02:38:29 INFO - 'PAGER': '/bin/cat', 02:38:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:38:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:29 INFO - 'PWD': '/builds/slave/test', 02:38:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:38:29 INFO - 'SHELL': '/bin/bash', 02:38:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BThm17ybZr/Listeners', 02:38:29 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 02:38:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:38:29 INFO - 'USER': 'cltbld', 02:38:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:38:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:38:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:29 INFO - 'XPC_FLAGS': '0x0', 02:38:29 INFO - 'XPC_SERVICE_NAME': '0', 02:38:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:38:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:38:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:38:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:38:31 INFO - Installing collected packages: mozsystemmonitor 02:38:31 INFO - Running setup.py install for mozsystemmonitor 02:38:32 INFO - Successfully installed mozsystemmonitor 02:38:32 INFO - Cleaning up... 02:38:32 INFO - Return code: 0 02:38:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109e34a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ec9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0a056c820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d98d30>, '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 0x109afddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d90b20>, '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.JoELRjERbo/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.BThm17ybZr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 02:38:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:38:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:38:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JoELRjERbo/Render', 02:38:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:38:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:38:32 INFO - 'HOME': '/Users/cltbld', 02:38:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:38:32 INFO - 'LOGNAME': 'cltbld', 02:38:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:32 INFO - 'MOZ_NO_REMOTE': '1', 02:38:32 INFO - 'NO_EM_RESTART': '1', 02:38:32 INFO - 'PAGER': '/bin/cat', 02:38:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:38:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:32 INFO - 'PWD': '/builds/slave/test', 02:38:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:38:32 INFO - 'SHELL': '/bin/bash', 02:38:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BThm17ybZr/Listeners', 02:38:32 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 02:38:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:38:32 INFO - 'USER': 'cltbld', 02:38:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:38:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:38:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:32 INFO - 'XPC_FLAGS': '0x0', 02:38:32 INFO - 'XPC_SERVICE_NAME': '0', 02:38:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:38:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:32 INFO - Downloading/unpacking jsonschema==2.5.1 02:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:38:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:35 INFO - Downloading functools32-3.2.3-2.tar.gz 02:38:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:38:35 INFO - warning: no files found matching '*.txt' 02:38:35 INFO - no previously-included directories found matching 'build' 02:38:35 INFO - no previously-included directories found matching 'dist' 02:38:35 INFO - no previously-included directories found matching '.git*' 02:38:35 INFO - Installing collected packages: jsonschema, functools32 02:38:35 INFO - Running setup.py install for functools32 02:38:35 INFO - warning: no files found matching '*.txt' 02:38:35 INFO - no previously-included directories found matching 'build' 02:38:35 INFO - no previously-included directories found matching 'dist' 02:38:35 INFO - no previously-included directories found matching '.git*' 02:38:35 INFO - Successfully installed jsonschema functools32 02:38:35 INFO - Cleaning up... 02:38:35 INFO - Return code: 0 02:38:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:38:35 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:35 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:35 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e34a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ec9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0a056c820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d98d30>, '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 0x109afddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d90b20>, '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.JoELRjERbo/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.BThm17ybZr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 02:38:35 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:38:35 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 functools32==3.2.3-2 02:38:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JoELRjERbo/Render', 02:38:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:38:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:38:35 INFO - 'HOME': '/Users/cltbld', 02:38:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:38:35 INFO - 'LOGNAME': 'cltbld', 02:38:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:35 INFO - 'MOZ_NO_REMOTE': '1', 02:38:35 INFO - 'NO_EM_RESTART': '1', 02:38:35 INFO - 'PAGER': '/bin/cat', 02:38:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:38:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:35 INFO - 'PWD': '/builds/slave/test', 02:38:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:38:35 INFO - 'SHELL': '/bin/bash', 02:38:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BThm17ybZr/Listeners', 02:38:35 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 02:38:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:38:35 INFO - 'USER': 'cltbld', 02:38:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:38:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:38:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:35 INFO - 'XPC_FLAGS': '0x0', 02:38:35 INFO - 'XPC_SERVICE_NAME': '0', 02:38:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:38:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:38:35 INFO - Cleaning up... 02:38:35 INFO - Return code: 0 02:38:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:38:35 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:35 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:35 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 0x109e34a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ec9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0a056c820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d98d30>, '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 0x109afddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d90b20>, '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.JoELRjERbo/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.BThm17ybZr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 02:38:35 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 02:38:35 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 02:38:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JoELRjERbo/Render', 02:38:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:38:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:38:35 INFO - 'HOME': '/Users/cltbld', 02:38:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:38:35 INFO - 'LOGNAME': 'cltbld', 02:38:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:35 INFO - 'MOZ_NO_REMOTE': '1', 02:38:35 INFO - 'NO_EM_RESTART': '1', 02:38:35 INFO - 'PAGER': '/bin/cat', 02:38:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:38:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:35 INFO - 'PWD': '/builds/slave/test', 02:38:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:38:35 INFO - 'SHELL': '/bin/bash', 02:38:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BThm17ybZr/Listeners', 02:38:35 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 02:38:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:38:35 INFO - 'USER': 'cltbld', 02:38:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:38:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:38:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:35 INFO - 'XPC_FLAGS': '0x0', 02:38:35 INFO - 'XPC_SERVICE_NAME': '0', 02:38:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:38:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:36 INFO - Downloading/unpacking blobuploader==1.2.4 02:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:38 INFO - Downloading blobuploader-1.2.4.tar.gz 02:38:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:38:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:38: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 02:38: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 02:38: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 02:38: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 02:38: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 02:38: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 02:38:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:38:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:38:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:38:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:38:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:38:39 INFO - Downloading docopt-0.6.1.tar.gz 02:38:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:38:39 INFO - Installing collected packages: blobuploader, requests, docopt 02:38:39 INFO - Running setup.py install for blobuploader 02:38:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:38:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:38:39 INFO - Running setup.py install for requests 02:38:40 INFO - Running setup.py install for docopt 02:38:40 INFO - Successfully installed blobuploader requests docopt 02:38:40 INFO - Cleaning up... 02:38:40 INFO - Return code: 0 02:38:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:40 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 0x109e34a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ec9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0a056c820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d98d30>, '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 0x109afddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d90b20>, '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.JoELRjERbo/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.BThm17ybZr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 02:38:40 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 02:38:40 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 02:38:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JoELRjERbo/Render', 02:38:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:38:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:38:40 INFO - 'HOME': '/Users/cltbld', 02:38:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:38:40 INFO - 'LOGNAME': 'cltbld', 02:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:40 INFO - 'MOZ_NO_REMOTE': '1', 02:38:40 INFO - 'NO_EM_RESTART': '1', 02:38:40 INFO - 'PAGER': '/bin/cat', 02:38:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:40 INFO - 'PWD': '/builds/slave/test', 02:38:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:38:40 INFO - 'SHELL': '/bin/bash', 02:38:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BThm17ybZr/Listeners', 02:38:40 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 02:38:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:38:40 INFO - 'USER': 'cltbld', 02:38:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:38:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:40 INFO - 'XPC_FLAGS': '0x0', 02:38:40 INFO - 'XPC_SERVICE_NAME': '0', 02:38:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:38:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:38:40 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-NVt4p_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:38:41 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-uvd32M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:38:41 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Wn_R4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:38:41 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-ITcE9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:38:41 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-ulnZhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:38:41 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-XogOQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:38:41 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-qDFFbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:38:41 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-jVWbNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:38:41 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-PX3uN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:38:41 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-r279cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:38:42 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-ewnVLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:38:42 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-5RHs2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:38:42 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-NsoZTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:38:42 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Y0H8NZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:38:42 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-f7Z6bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:38:42 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-PSB41L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:38:42 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Mp6qQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:38:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:38:42 INFO - Running setup.py install for manifestparser 02:38:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:38:42 INFO - Running setup.py install for mozcrash 02:38:43 INFO - Running setup.py install for mozdebug 02:38:43 INFO - Running setup.py install for mozdevice 02:38:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:38:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:38:43 INFO - Running setup.py install for mozfile 02:38:43 INFO - Running setup.py install for mozhttpd 02:38:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:38:43 INFO - Running setup.py install for mozinfo 02:38:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:38:43 INFO - Running setup.py install for mozInstall 02:38:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:38:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:38:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:38:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:38:43 INFO - Running setup.py install for mozleak 02:38:44 INFO - Running setup.py install for mozlog 02:38:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:38:44 INFO - Running setup.py install for moznetwork 02:38:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:38:44 INFO - Running setup.py install for mozprocess 02:38:44 INFO - Running setup.py install for mozprofile 02:38:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:38:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:38:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:38:44 INFO - Running setup.py install for mozrunner 02:38:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:38:44 INFO - Running setup.py install for mozscreenshot 02:38:45 INFO - Running setup.py install for moztest 02:38:45 INFO - Running setup.py install for mozversion 02:38:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:38:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:38:45 INFO - Cleaning up... 02:38:45 INFO - Return code: 0 02:38:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:38: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:45 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 0x109e34a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ec9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0a056c820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d98d30>, '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 0x109afddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d90b20>, '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.JoELRjERbo/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.BThm17ybZr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 02:38:45 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 02:38:45 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 02:38:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JoELRjERbo/Render', 02:38:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:38:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:38:45 INFO - 'HOME': '/Users/cltbld', 02:38:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:38:45 INFO - 'LOGNAME': 'cltbld', 02:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:45 INFO - 'MOZ_NO_REMOTE': '1', 02:38:45 INFO - 'NO_EM_RESTART': '1', 02:38:45 INFO - 'PAGER': '/bin/cat', 02:38:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:45 INFO - 'PWD': '/builds/slave/test', 02:38:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:38:45 INFO - 'SHELL': '/bin/bash', 02:38:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BThm17ybZr/Listeners', 02:38:45 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 02:38:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:38:45 INFO - 'USER': 'cltbld', 02:38:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:38:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:45 INFO - 'XPC_FLAGS': '0x0', 02:38:45 INFO - 'XPC_SERVICE_NAME': '0', 02:38:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:38:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:38:45 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-snhUX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:38:45 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)) 02:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:38:45 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-O7Rjk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:38:45 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)) 02:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:38:45 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-f9rxcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:38:45 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)) 02:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:38:45 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-xBJqng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:38:46 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)) 02:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:38:46 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-230rHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:38:46 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)) 02:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:38:46 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-IygP_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:38:46 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)) 02:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:38:46 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-aUb6Cp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:38:46 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)) 02:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:38:46 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-QnverZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:38:46 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)) 02:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:38:46 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-DUtdyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:38:46 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)) 02:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:38:46 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-bFNdu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:38:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 02:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:38:46 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-3MoFqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:38:46 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)) 02:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:38:46 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-q9Cdpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:38:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 02:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:38:46 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-ZbWm4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:38:46 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)) 02:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:38:46 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-OJk0rI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:38:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 02:38:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:38:47 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-RgOXYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:38:47 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)) 02:38:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:38:47 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-oNDo_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:38:47 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)) 02:38:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:38:47 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-NVFzeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:38:47 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)) 02:38:47 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)) 02:38:47 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)) 02:38:47 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)) 02:38:47 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)) 02:38:47 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)) 02:38:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:38:47 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 02:38:47 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 02:38:47 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 02:38:47 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 02:38:47 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 02:38:47 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 02:38:49 INFO - Downloading blessings-1.6.tar.gz 02:38:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:38:50 INFO - Installing collected packages: blessings 02:38:50 INFO - Running setup.py install for blessings 02:38:50 INFO - Successfully installed blessings 02:38:50 INFO - Cleaning up... 02:38:50 INFO - Return code: 0 02:38:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:38:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:38:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:38:50 INFO - Reading from file tmpfile_stdout 02:38:50 INFO - Current package versions: 02:38:50 INFO - blessings == 1.6 02:38:50 INFO - blobuploader == 1.2.4 02:38:50 INFO - docopt == 0.6.1 02:38:50 INFO - functools32 == 3.2.3-2 02:38:50 INFO - jsonschema == 2.5.1 02:38:50 INFO - manifestparser == 1.1 02:38:50 INFO - mozInstall == 1.12 02:38:50 INFO - mozcrash == 0.17 02:38:50 INFO - mozdebug == 0.1 02:38:50 INFO - mozdevice == 0.48 02:38:50 INFO - mozfile == 1.2 02:38:50 INFO - mozhttpd == 0.7 02:38:50 INFO - mozinfo == 0.9 02:38:50 INFO - mozleak == 0.1 02:38:50 INFO - mozlog == 3.3 02:38:50 INFO - moznetwork == 0.27 02:38:50 INFO - mozprocess == 0.23 02:38:50 INFO - mozprofile == 0.28 02:38:50 INFO - mozrunner == 6.12 02:38:50 INFO - mozscreenshot == 0.1 02:38:50 INFO - mozsystemmonitor == 0.3 02:38:50 INFO - moztest == 0.7 02:38:50 INFO - mozversion == 1.4 02:38:50 INFO - psutil == 3.1.1 02:38:50 INFO - requests == 1.2.3 02:38:50 INFO - wsgiref == 0.1.2 02:38:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:38:50 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:50 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:50 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 0x109e34a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ec9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0a056c820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d98d30>, '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 0x109afddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d90b20>, '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.JoELRjERbo/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.BThm17ybZr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 02:38:50 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 02:38:50 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 02:38:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JoELRjERbo/Render', 02:38:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:38:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:38:50 INFO - 'HOME': '/Users/cltbld', 02:38:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:38:50 INFO - 'LOGNAME': 'cltbld', 02:38:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:50 INFO - 'MOZ_NO_REMOTE': '1', 02:38:50 INFO - 'NO_EM_RESTART': '1', 02:38:50 INFO - 'PAGER': '/bin/cat', 02:38:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:38:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:50 INFO - 'PWD': '/builds/slave/test', 02:38:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:38:50 INFO - 'SHELL': '/bin/bash', 02:38:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BThm17ybZr/Listeners', 02:38:50 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 02:38:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:38:50 INFO - 'USER': 'cltbld', 02:38:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:38:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:38:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:50 INFO - 'XPC_FLAGS': '0x0', 02:38:50 INFO - 'XPC_SERVICE_NAME': '0', 02:38:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:38:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:50 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)) 02:38:50 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)) 02:38:50 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)) 02:38:50 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)) 02:38:50 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)) 02:38:50 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)) 02:38:50 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)) 02:38:50 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)) 02:38:50 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)) 02:38:50 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)) 02:38:50 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)) 02:38:50 INFO - Cleaning up... 02:38:50 INFO - Return code: 0 02:38:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:38:50 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:50 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:38:50 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 0x109e34a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ec9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0a056c820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d98d30>, '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 0x109afddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d90b20>, '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.JoELRjERbo/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.BThm17ybZr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 02:38:50 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 02:38:50 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 02:38:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JoELRjERbo/Render', 02:38:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:38:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:38:50 INFO - 'HOME': '/Users/cltbld', 02:38:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:38:50 INFO - 'LOGNAME': 'cltbld', 02:38:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:50 INFO - 'MOZ_NO_REMOTE': '1', 02:38:50 INFO - 'NO_EM_RESTART': '1', 02:38:50 INFO - 'PAGER': '/bin/cat', 02:38:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:38:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:50 INFO - 'PWD': '/builds/slave/test', 02:38:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:38:50 INFO - 'SHELL': '/bin/bash', 02:38:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BThm17ybZr/Listeners', 02:38:50 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 02:38:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:38:50 INFO - 'USER': 'cltbld', 02:38:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:38:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:38:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:50 INFO - 'XPC_FLAGS': '0x0', 02:38:50 INFO - 'XPC_SERVICE_NAME': '0', 02:38:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:38:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:38:51 INFO - Cleaning up... 02:38:51 INFO - Return code: 0 02:38:51 INFO - Running post-action listener: _resource_record_post_action 02:38:51 INFO - Running post-action listener: _start_resource_monitoring 02:38:51 INFO - Starting resource monitoring. 02:38:51 INFO - [mozharness: 2016-08-06 09:38:51.116081Z] Finished create-virtualenv step (success) 02:38:51 INFO - [mozharness: 2016-08-06 09:38:51.116985Z] Running install step. 02:38:51 INFO - Running pre-action listener: _resource_record_pre_action 02:38:51 INFO - Running main action method: install 02:38:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:38:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:38:51 INFO - Reading from file tmpfile_stdout 02:38:51 INFO - Detecting whether we're running mozinstall >=1.0... 02:38:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:38:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:38:51 INFO - Reading from file tmpfile_stdout 02:38:51 INFO - Output received: 02:38:51 INFO - Usage: mozinstall [options] installer 02:38:51 INFO - Options: 02:38:51 INFO - -h, --help show this help message and exit 02:38:51 INFO - -d DEST, --destination=DEST 02:38:51 INFO - Directory to install application into. [default: 02:38:51 INFO - "/builds/slave/test"] 02:38:51 INFO - --app=APP Application being installed. [default: firefox] 02:38:51 INFO - mkdir: /builds/slave/test/build/application 02:38:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:38:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 02:39:25 INFO - Reading from file tmpfile_stdout 02:39:25 INFO - Output received: 02:39:25 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:39:25 INFO - Running post-action listener: _resource_record_post_action 02:39:25 INFO - [mozharness: 2016-08-06 09:39:25.993577Z] Finished install step (success) 02:39:25 INFO - [mozharness: 2016-08-06 09:39:25.993714Z] Running run-tests step. 02:39:25 INFO - Running pre-action listener: _resource_record_pre_action 02:39:25 INFO - Running main action method: run_tests 02:39:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:39:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:39:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:39:26 INFO - 2016-08-06 02:39:26.007 screenresolution[1654:8612] starting screenresolution argv=screenresolution get 02:39:26 INFO - 2016-08-06 02:39:26.010 screenresolution[1654:8612] Display 0: 1600x1200x32@60 02:39:26 INFO - 2016-08-06 02:39:26.016 screenresolution[1655:8614] starting screenresolution argv=screenresolution list 02:39:26 INFO - Available Modes on Display 0 02:39:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:39:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:39:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:39:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:39:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:39:26 INFO - Intel Iris: 02:39:26 INFO - Chipset Model: Intel Iris 02:39:26 INFO - Type: GPU 02:39:26 INFO - Bus: Built-In 02:39:26 INFO - VRAM (Dynamic, Max): 1536 MB 02:39:26 INFO - Vendor: Intel (0x8086) 02:39:26 INFO - Device ID: 0x0a2e 02:39:26 INFO - Revision ID: 0x0009 02:39:26 INFO - Displays: 02:39:26 INFO - Display: 02:39:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:39:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:39:26 INFO - Display Serial Number: 1600x1200 60 02:39:26 INFO - Main Display: Yes 02:39:26 INFO - Mirror: Off 02:39:26 INFO - Online: Yes 02:39:26 INFO - Rotation: Supported 02:39:26 INFO - Return code: 0 02:39:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:39:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:39:26 INFO - Python 2.7.3 02:39:26 INFO - Return code: 0 02:39:26 INFO - grabbing minidump binary from tooltool 02:39:26 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:39:26 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 0x109d98d30>, '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 0x109afddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d90b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:39:26 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 02:39:26 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 02:39:26 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 02:39:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:39:26 INFO - Return code: 0 02:39:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:39:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:39:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:39:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:39:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:39:26 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HrEATJ_oSOuhs3VuUkSrXg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0102', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:39:26 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-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HrEATJ_oSOuhs3VuUkSrXg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0102 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:39:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JoELRjERbo/Render', 02:39:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:39:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:39:26 INFO - 'HOME': '/Users/cltbld', 02:39:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:39:26 INFO - 'LOGNAME': 'cltbld', 02:39:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:39:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:39:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:26 INFO - 'MOZ_NO_REMOTE': '1', 02:39:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:39:26 INFO - 'NO_EM_RESTART': '1', 02:39:26 INFO - 'PAGER': '/bin/cat', 02:39:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:39:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:26 INFO - 'PWD': '/builds/slave/test', 02:39:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:39:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:39:26 INFO - 'SHELL': '/bin/bash', 02:39:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BThm17ybZr/Listeners', 02:39:26 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 02:39:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:39:26 INFO - 'USER': 'cltbld', 02:39:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:39:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:39:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:26 INFO - 'XPC_FLAGS': '0x0', 02:39:26 INFO - 'XPC_SERVICE_NAME': '0', 02:39:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:39:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HrEATJ_oSOuhs3VuUkSrXg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0102', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:39:26 INFO - mozversion application_buildid: 20160805234720 02:39:26 INFO - mozversion application_changeset: 115ec609a6bf1bbc3e06f7cd2caa99e53b51e5d1 02:39:26 INFO - mozversion application_display_name: Nightly 02:39:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:39:26 INFO - mozversion application_name: Firefox 02:39:26 INFO - mozversion application_remotingname: firefox 02:39:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:39:26 INFO - mozversion application_vendor: Mozilla 02:39:26 INFO - mozversion application_version: 51.0a1 02:39:26 INFO - mozversion platform_buildid: 20160805234720 02:39:26 INFO - mozversion platform_changeset: 115ec609a6bf1bbc3e06f7cd2caa99e53b51e5d1 02:39:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:39:26 INFO - mozversion platform_version: 51.0a1 02:39:26 INFO - using testdate: 1470476366 02:39:26 INFO - actual date: 1470476366 02:39:26 INFO - starting webserver on 'localhost:49273' 02:39:26 INFO - SUITE-START | Running 2 tests 02:39:26 INFO - TEST-START | dromaeo_css 02:39:26 INFO - operating with platform_type : mac_ 02:39:26 INFO - Initialising browser for dromaeo_css test... 02:39:26 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpZNBEx1/profile http://localhost:49273/getInfo.html) 02:39:29 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 02:39:29 INFO - PROCESS | 1665 | colorDepth:24 02:39:29 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 02:39:29 INFO - PROCESS | 1665 | __metrics 02:39:29 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 02:39:30 INFO - TEST-INFO | 1665: exit 0 02:39:30 INFO - Browser initialized. 02:39:30 INFO - Running cycle 1/1 for dromaeo_css test... 02:39:30 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpZNBEx1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:39:42 INFO - PROCESS | 1669 | RSS: Main: 254664704 02:39:42 INFO - PROCESS | 1669 | 02:40:31 INFO - PROCESS | 1669 | 1470476431950 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] 02:42:44 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 02:42:46 INFO - PROCESS | 1669 | RSS: Main: 267304960 02:42:46 INFO - PROCESS | 1669 | 02:45:48 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 02:45:49 INFO - PROCESS | 1669 | RSS: Main: 280043520 02:45:49 INFO - PROCESS | 1669 | 02:48:50 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 02:48:51 INFO - PROCESS | 1669 | RSS: Main: 287420416 02:48:51 INFO - PROCESS | 1669 | 02:51:53 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 02:51:54 INFO - PROCESS | 1669 | RSS: Main: 285839360 02:51:54 INFO - PROCESS | 1669 | 02:54:56 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 02:54:57 INFO - PROCESS | 1669 | RSS: Main: 291102720 02:54:57 INFO - PROCESS | 1669 | 02:58:00 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 02:58:00 INFO - PROCESS | 1669 | RSS: Main: 292200448 02:58:00 INFO - PROCESS | 1669 | 02:58:00 INFO - PROCESS | 1669 | __start_tp_report 02:58:00 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 02:58:00 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 02:58:00 INFO - PROCESS | 1669 | |i|pagename|runs| 02:58:00 INFO - PROCESS | 1669 | |0;dojo.html;2968.4656761782876;3369.275605744766;3382.0530251529567;3394.2532642818587;3434.450487921933;4598.425196850394;5510.752016159272;5551.666899986004;5573.86065348366;5621.409751976034;4739.763011849411;5461.2354270402175;5519.530839878616;5592.356878958911;5702.800401985931;4956.826511072113;5021.221710634839;5047.47001564834;5068.569171620398;5265.86835329116;5153.3558305211845;5193.740312984354;5201.86995325118;5244.895102097956;5261.026710058652;4549.909001819961;5068.26510156029;5091.1854103343285;5197.948020519784;5222.16445368743;5105.387353517564;5145.897082058338;5195.5324020837925;5220.947790522122;5224.138017227153;4279.764612946286;4284.978575107136;4370.847020354304;5076.060928728197;5145.794168233266;5442.673439593597;5510.724463776835;5606.859828504279;5634.746436410372;5647.068233741427;6093.756249750005;6098.786542471036;6100.389961003909;6113.962834745944;6118.3146263159115;6199.814005579839;6235.688215589248;6257.812265631993;6280.869443500168;6301.054841773725;5703.734303532216;5712.80005199816;5718.399568045378;5720.542356611461;5769.990251705976;4825.445073816486;6218.875622487615;6277.654728989858;6279.654618995999;6324.557280990379;6105.145279660851;6117.449429551361;6120.112583675342;6126.050462178369;6169.753209871555;6101.755929762849;6115.544587952024;6153.692315384213;6178.505719542426;6261.186045814015;4909.926351104737;6154.076888466766;6195.473384762256;6195.504359651217;6202.875942481125;6177.598456100339;6211.2857021443115;6218.844528886814;6231.563790534709;6241;4801.327814106028;4852.539008794159;4872.731999739977;4890.388701412324;4906.092372911023;4410.625096866802;4413.426254586947;4426.159029784395;4426.468823741172;4464.687471877002;5757.193992841006;5781.682007489544;5854.414558544111;5872.060470324813;5875.41245875409;6122.093225952662;6196.845078873064;6209.285932117864;6214.40963108504;6284.780032698834;5779.3642699303045;5800.796972105956;5808.215890854681;5820.447057529528;5841.386654401226;5396.541293990055;5403.946230485018;5434.103372943499;5451.890962180813;5460;6239.96880015597;6244.7814326499265;6259.311475737574;6272.435480806749;6326.715297811609;6250.812475625738;6271.717772700331;6300.306966233802;6316.715747791269;6340.778072767431;6269.310375858743;6270.184875966095;6309.684515774285;6345.714442850175;6353.205849268841;6058.363871793575;6088.330283668704;6102.307478454246;6150.769846030722;6188.381161883775;4741.336212930123;6260.248770147611;6279.686015699288;6286.52851036165;6286.937130628635;5954.791582294599;6130.601510901777;6130.969345153246;6145.84635384119;6161.291451483136;5229.398619158694;5917.970410148094;6042.697865106815;6054.697265136813;6165.290991536031;4656.720596764205;5687.829365119053;5867.589268751147;5896.410358964069;5971.4327138921735;6043.576949613484;6075.119107729266;6088.4215999479975;6118.847028824315;6121;4887.462379138221;4964.726940018334;5673.687947162945;5765.596408251382;5812.82561523155 02:58:00 INFO - PROCESS | 1669 | |1;ext.html;514.8995945790572;520.9374875014997;526.4367127173923;537.8359600321903;543.50541007683;37292;41663;41690.16619667605;41695.95760105999;41768.16463670728;42458;42896;43018.70943871681;43028;43221.78389108058;9554.283428742838;9572.28207884408;9641.710748677517;9675.70972870815;9707.660231891885;9549.809003819953;9587.520623968809;9655.90344096557;9675.70972870815;9688.370255933378;8370.414071015031;9661.130498255156;9690.127888490035;9707.223422126248;9719.805603887919;9643;9692.273079519064;9693.079157480028;9703.320767546275;9722.805543889153;9598.280128990284;9667.854982175273;9672.468014259213;9676.467794271382;9703;39631;39887.20225595501;39907;40064.79967600173;40225.59774402277;3016.638003439601;3247.8538465769097;3300.290437555937;3377.121948293461;3478.3738926993133;27068.244744573134;31027.844860775553;31074.378512429852;31130.377392452025;31318.06045818629;2725.38678797271;2833.6741274753463;2853.800233983622;2854.2864283929016;2863.5847802068583;459533;461132;465177;465588.68822623696;467204;32456;32611.347773044406;32657.67342326594;32671.509927351108;32699.673003270138;31313.373732525222;31709.20726981844;31843.044708658777;34566.65433345635;34624;16692.499225023268;16719.665606688042;16836.494905152864;16866.241019154168;16876.240569174417;12787.744245115231;12942.870571294166;12947.287899165449;12950.093493455555;12962.67593310156;16535.586610334838;18388.620853436045;19217.135228914452;19346.903265483583;19470.221191152195;7790.454668173174;7921.247481489249;7948.443608947318;7959.44283900133;7969.924060251908;699.653671432644;782.2490409207225;931.2968708625081;937.962481500746;1079.9460026998618;30213.546796798066;31115.377692446476;31393.8430307847;31645.52531712026;31762.682373176434;968.6561270748923;986.7977064701719;1007.1942446043137;1040.7242080848582;1059.380262546419;13833.409157946764;16110.838891611169;16199.352025918832;16241.756373654405;16481.25834337458;697215;786182;786846;1019444;1044243;56097;62122.689386552775;62205.06692399618;62902;65723.34276657172;1332.8667133286788;1389.9305034748222;1423.5088894331232;1428.992855035718;1431.799548063272;25658.486830263664;28355;31582.526262105628;31727.206819829687;33161.77672543247;54597;55311.61720957008;55755.16367254576;55826.44173558213;55920;512008;513524;515345;518673;520792;44827.775861120484;45268.54731452643;45431.772841135586;45785.4817985014;45808.08383832371;49638.50361496339;50175.49824501854;50544.49455505545;51059;51078;36700.082497937765;38828.6117138825;41423.37864931968;41481;42976.78511607547;40379.19241615092;40732.59267407288;41155.38266926059;41201.969950751474;42645.36031959461;32680;33920.491192632624;38806.61193388143;39830.402543962446;39980;34623.82688086543;35741.642583573834;36440.45339319859;36603.450948235266;36740.63259367372;26033.349166270993;26402.86798565995;27084;33589.496157557165;34186.65813341835 02:58:00 INFO - PROCESS | 1669 | |2;jquery.html;360.6663835951744;376.53685966261503;379.9753016053957;384.724921680998;394.64087680211014;19533.609327813454;21586.812725300104;21802;21815.890920545397;22345;20600.484987875272;20805.791942080574;21592.784072159273;21594.676079858815;21790.45523861904;4888.608911287089;5665.773369065253;5933.910991335112;6040.456358927696;6085.847853803668;5943.465088142067;5995.460408563228;6017.669028203447;6040.305364883029;6094.573379863411;6003.279606447232;6006;6008.218931538894;6175.197224360827;6326.49388048955;6639.734410623618;6699.129113215299;6750.864982700343;6827.52207345486;6829.248782633907;4944.728039957801;5002.424721157041;5958;5965.522758179335;6036.63780173191;25274.98900043996;25449.745502544924;25609;25751.35621609456;25775.613365799527;2098.2551194325947;2149.57008598281;2177.7822217778253;2219.8113160381386;2293.415179129311;9991.850122248172;9991.950040249825;10050.648227312082;10095;10205.897941020643;1883.877547959392;1899.3921944977612;1938.1375287996848;1956.168628332967;1968.2422267427144;126722;130476;130592;131631;132131;9567.521623918776;11383.203175777617;11455.484503197376;11520.94239528797;11670.066394688405;12176.208546444454;13310.535841057475;14074.225917574428;14550.4907328243;14561.490347837987;8006.279434850891;8421.410501264974;8584.8712269316;8612.052674205832;8747.212750852454;7061.717531298793;8180;8459.900212972274;8506.447080939719;8636.006859211271;3932.744371615836;4407.691461597721;4431.249656385709;4494.977525112419;4595.954040459619;1851.1669748612908;1881.7459642948027;1912.550550620603;1913.2538310059088;1917.9266517273795;748.4386709967415;816.7958010497375;876.8202518483696;910.9043550427242;944.40502483435;16706.24821883018;20822.27122050721;21047;21766.782332176477;21984.560308793734;881.405051590174;896.9506677132821;904.9230815380766;955.4219697083304;1002.734275417015;10841.349519028883;11619.128565357632;11657.417129143509;11667.299962002136;11678.591249306233;577393;580375;580417;610984;623699.4595351288;99166.51250231253;126397;135563;136638;141614;826.7850358906608;926.9258459323238;937.7421209167397;974.697843668465;1001.1690297053428;19360.8383496985;19561.23948844554;19991.900040499706;19997.300094496622;19999.500012499804;57045.14432283602;57525.84948301094;57980.71009644925;60057.69971150116;60737.392626073175;86009;86641;87730.56134719285;87760.1223987752;88474;8008.399370047153;8193.83612327762;8196.303314218358;8209.179082091981;8349.290310323448;12737.745245095231;13185.868141318848;13252.536161234311;13428.060035797791;13602.183868967893;9678.322517423712;9731.951340243253;10420.374777513374;11383.715407114889;11684.766304674029;9261.67584134552;10237;10816.08063314627;11201.984379980913;11471.254368466023;10983.835242471529;11604.419779011185;11790.469428875549;11900.464479098287;12005.279683219034;7228.168760592389;7338.743143989935;8238.917610823815;8327.286823246459;8442.746717598482;10777;11440.453459427605;11597.07223422141;11615.941920290683;11651.76696466049 02:58:00 INFO - PROCESS | 1669 | |3;mootools.html;1376.9793453098202;1517.7799219113228;1701.5661006443356;1834.192955099756;1858.0523932794288;7781.182975787546;8223.671053157874;8399.748007559783;8683.565821708913;8740.694075707352;7273.236310187433;8614.956925215381;8627.698030568916;8634.26608738258;8658.95670521648;2309.480366917447;2330.568844763716;2356.3284463927785;2359.634256690216;2366.325597204797;2331.62693968965;2344.6951896253463;2369.727481339642;2370.727366352866;2373.9762602373926;2345.85924844509;2348.2133485282366;2348.5655153796515;2370.9881450592725;2371.762823717623;2329.7087864017;2351.7413084560685;2353.51752890657;2361.681173041635;2365.2667673021333;2334.789868911806;2336.4859730859184;2337.100216416675;2340.6020976434047;2345.39019854839;8592.398532102756;8615.784605384853;8646.265067469272;8672.826543469158;8681.739547813575;5052.873678158076;5161.329027226474;5267.47325267474;5271.103912334874;5287.154055351125;3431.1079119428878;3555.964440355615;3585.3904836177912;3610.9277814443826;3669.9633003670156;1054.8945105489465;1081.2377274021796;1099.3294090604725;1111.3220935229504;1112.7830073135742;11153.275037122561;11189.944050279777;11256.043236324922;11275.210735248536;11276.43617819114;4455.1980643484485;4560.1335746208115;4725.69282996611;4727.338172655831;4764.6426518011285;9406.90593094074;9556.522173891417;9584.329096963145;9592.712218633453;9604.615815367446;4538.523455037173;5050.873728156826;5213.165893457104;5222.503862133091;5224.895502089937;4324.091940692427;4651.162790697639;4761.142994260997;4794.688345257547;4808.975955120202;3818.4272359145793;3887.416887466846;3927.9410808837893;3956.2680904032845;3983.3626619740703;1259.1626568331956;1263.684078980255;1269.2574843716345;1271.8728127187208;1279.7568461992191;852.7910661887753;853.5220276645099;898.3172788680649;915.5285028210477;955.6273053509137;5557.666540007613;5607.8503906699025;5814.06974884025;5873.647581145145;5975.701214939236;744.7095632703142;857.6508733396098;899.4288626722079;902.9210093937812;919.5310391700148;3803.5625903021505;3854.479645247912;3890.183061557048;3960.7227494075714;3998.540167880731;10188.235882308856;10458.320209186379;10506.317089389166;10551.15590752738;10589.09992650618;10511.94744026275;10519.26365154432;10521.52653130611;10534.841977370346;10538.156947444186;8063.516189028677;8184.099749027602;8192.262696357357;8195.877061844078;8213.671453141927;4832.540908613676;5430.185472179205;5519.917201241904;5783.681897495678;5796.275465566804;8076.475029123323;9392.859107113536;9779.364341317792;9801.460919649202;9828.950855245965;8393.37049721261;9481.146696797321;9909.306348555532;9918.256130790076;9935;6869.072675188786;7103.502754807114;7376.520526165782;7380.483366164317;7552.67828130064;8293.543855088028;8347.165283471604;8369.707060252862;8376.413651044368;8386.958065209636;6316.873662526816;6508.153939987771;7386.261373862786;7406.222346653523;7427.071616047994;7187.820304492429;7250.782476525713;7266.982622432758;7270.927290727025;7292.744753933587;6711.932880671131;6773;6821.2155602106395;6822.044913712183;6838.760643377458;4847.733374664286;4904.362432883702;4966.726830024383;5020.246962955586;5035.59715222774;4087.8569250076102;4906.165951788276;4971;5043.773030213722;5073.188289873602 02:58:00 INFO - PROCESS | 1669 | |4;prototype.html;266.22793897696675;279.06095987003727;297.45714071818935;311.1567651663991;313.87445021991203;4838.806447742095;5234.906037584968;5481.835544933653;5513.255710479084;5531.308586426697;4765.761711914408;4970.4284007339165;5423.538999185064;5455.290812194409;5467.20725494804;3848.980020294624;4110.424540564323;4119.855805046832;4172.603602657743;4189.22499337622;3858.401947698097;4149.398337241113;4190.308599081148;4197.832086716543;4212.55768144345;3562.69717074049;3964.83037503937;4104.610062044101;4104.8152833122585;4135.607117323864;4104.712670113093;4135.276326642856;4145.357469592218;4152.522459917118;4153.8961525961795;3538.2569660371355;3545.3263879862743;3551.6093229744706;3561.5904171020406;3564.9821750891338;5117.309163262949;5229.660072095339;5249.2388603652635;5277.754181178586;5309.7610607522365;4302.182585308781;4371.650267978586;4701.224297990828;4725.291206319045;4788.6056971514245;4552.021315417202;4782.306565547976;5789.942100578983;5806.361300256968;5821.941780582182;3313.370459612666;3496.5978912425144;3886.4947556817433;3894.6300101490315;3956.8219430125428;4722.574968252839;4906.582940450066;4956.851294461172;5944.227250457456;6023.668698221596;3808.21931504041;3962.583928687446;3968.8093571928307;3979.840806367713;3992.7604343739467;3496.5804103507744;3632.2735452909524;3963.147923196527;3971.9345940111557;4043.737157084839;4465.486469056035;4673.859784206479;4713.599344055725;4719.159527784098;4733.171694953369;5093.261477085802;5381.865453363619;5458.890822183614;5791.044477661223;5881.794137205177;1139.7207684117445;1179.7404570994368;1236.9690757731128;1320.2408615046386;1353.8036984637172;815.1807433529265;864.338780832651;868.9261412779985;913.6802119258207;915.7298596913927;5355.464453554613;5396.379416367168;5412.242286079952;5412.810551630674;5462.098753705594;5153.742312884341;5362.222477740784;5899.262592175978;5928.0952333356345;5965.79119730816;4730.52694730531;4949.604031677457;5064.240363945364;5405.405405405402;5408.161734931092;2795.2452837734104;2884.4952133376573;3153.243221626839;3155.3216058547523;3162.968370316313;5181.445566330086;5215.765290561933;5583.497485226268;5685.403032681592;6198.969005154945;5584.748686309126;6065.332813390523;6129.325774164839;6138.1099740537375;6157.322694503601;5659.830205093854;5902.704864756745;6273.96863015682;6277.591956522902;6303.1175635412;5537.944620553743;5683.453237410138;5921.526277897844;5979.402059793986;6061.575689701855;5295.470452954673;5580.35825880029;5834.299884013945;5909.940900591111;5914.550935020948;5185.640533557147;6182.165407669907;6196.977498712842;6204.231793938706;6206.565540412128;3115.6417012043903;3662.230931504307;3960.405939109157;3999.3201155803004;4009.278329900646;4542.931856022096;4866.562009419169;5978.953683105527;6053.3982280543005;6057.878842423215;4720.622350212044;4976.462004377721;5335.546478549211;5602.52378547828;5777;4558.020025694359;5417.160340147283;5458.399576046711;5664.366069777573;5796.42035796417;5152.433232344364;5377.821982097257;5529.640573362719;5649.519790817826;5696.003199440164;4584.793684284148;5046.268291097844;5471.480209380103;5829.7959571416495;5839.941600584109;4928.852134435972;5667.498112999976;5683.77264909399;5693.373728889902;5704.2014118024335 02:58:00 INFO - PROCESS | 1669 | |5;yui.html;687.8624275144971;723.5947869193252;785.603270348474;795.6181033104107;813.4021494201762;15126.168060756654;15786.605334866634;15934.442294519695;15976.520704378872;15982.360705571778;14415.279236038208;14419.134851908893;14468.348924298405;14500.637484062903;14525.92737036316;588.8351261646725;836.4103307168463;844.2106630300658;864.191980498233;873.8208667223204;864.2437866866492;867.5445391169624;871.3073106880046;871.960761765722;872.2062922740307;887.9866801997975;926.0878035135386;926.2775035472308;926.3376685669745;928.8003079337941;900.5947323704327;914.1178762494225;914.3690853311227;914.4878867834001;914.4878867834034;671.2314400012008;675.4326365852659;678.4775722693498;678.9592624442549;679.1171477079777;14692.926535367362;14697;14717.852821471755;14717.92641036788;14746.26268686572;14554.927225363912;14601.488947886879;14622.853771462256;14669.559913202622;14721.631959201106;10928.726781830439;12064.698382540419;12475.812862807064;12546.874531254662;12553.184043037174;3819.312523745725;3848;4034.3545032794905;4072.0430698785763;4075.9810047488127;122239.38880305631;122743.3862830689;125585;125605.37197314046;125757;11057.889421105847;11259.98660120593;11417.48621312043;11458.484368203452;11900.880991189977;22411.32766017022;22659.320220393416;23041.308760737204;23051.538969220856;23085.422864428187;8043.11525732169;8081;8102.39232057598;8209.876851847228;8377.706780262783;4468.374427580141;4495.865124046284;4520.367148599199;4528.637708983273;4673.205555055649;3051.2371907023244;3079.7690173237097;3656.542932133483;3717.368047431943;3863.690904727615;716.6273537760335;725.5465334166146;726.5241266970143;726.6185252742353;740.7888751705738;603.2399177036965;655.1319501660224;670.165643773505;687.689950644024;706.9222385537587;8356.78826570144;9617.134457898683;9733.561989710339;9775.511224438891;9914.702558923243;580.2109131581046;614.7878981751378;634.0647544871371;698.5599072584341;706.4313227851526;4362.302031674917;4568.520305367955;4829.589484893753;4860.635452341088;4881.292212629149;122110.38944805218;146069.3482662942;158423;176268.23731762776;181134;107834.46082769537;147021;150911.49088509195;151448;152933;130311.34844325717;131000;131262;132116.3394183023;132334;7109.897965815307;8427.705030323908;9131.77170570741;9183.678571249975;9269.72190834276;62039.6898015507;64453.67773161104;65859;66386.66806665936;66871.99692004721;77204;89704.5514772422;95498;96645.30192282729;98061.50969245109;11957.393310037118;12073;12256.509739610672;12342.629721108022;12812.743745125232;13547.525836595672;13720.86279137196;13853.445862165401;14132.222727750073;14391.208483533506;12737.745245095231;12898.290594017044;13084.672883177996;13403.731925361242;13504.662383440493;12230.44962976686;12736.490540378281;13157.144785588906;13160.868391316348;13216.405261763051;12257.570985015482;12704.237745735285;12706.237625742486;13129.277889716157;13164.80252796228;10432.791344173225;10864.45677716127;11108.722281943015;11139.33164010162;11289.661310160709;8621.784455388666;9814.938862838884;9936.155426788515;10912.072473839813;10915.126789856951 02:58:00 INFO - PROCESS | 1669 | __end_tp_report 02:58:00 INFO - PROCESS | 1669 | __start_cc_report 02:58:00 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,418 02:58:00 INFO - PROCESS | 1669 | __end_cc_report 02:58:00 INFO - PROCESS | 1669 | __startTimestamp1470477480631__endTimestamp 02:58:00 INFO - PROCESS | 1669 | 02:58:00 INFO - PROCESS | 1669 | ------- Summary: start ------- 02:58:00 INFO - PROCESS | 1669 | Number of tests: 6 02:58:00 INFO - PROCESS | 1669 | 02:58:00 INFO - PROCESS | 1669 | [#0] dojo.html Cycles:165 Average:5633.96 Median:5841.39 stddev:698.68 (12.0%) stddev-sans-first:668.80 02:58:00 INFO - PROCESS | 1669 | Values: 2968.5 3369.3 3382.1 3394.3 3434.5 4598.4 5510.8 5551.7 5573.9 5621.4 4739.8 5461.2 5519.5 5592.4 5702.8 4956.8 5021.2 5047.5 5068.6 5265.9 5153.4 5193.7 5201.9 5244.9 5261.0 4549.9 5068.3 5091.2 5197.9 5222.2 5105.4 5145.9 5195.5 5220.9 5224.1 4279.8 4285.0 4370.8 5076.1 5145.8 5442.7 5510.7 5606.9 5634.7 5647.1 6093.8 6098.8 6100.4 6114.0 6118.3 6199.8 6235.7 6257.8 6280.9 6301.1 5703.7 5712.8 5718.4 5720.5 5770.0 4825.4 6218.9 6277.7 6279.7 6324.6 6105.1 6117.4 6120.1 6126.1 6169.8 6101.8 6115.5 6153.7 6178.5 6261.2 4909.9 6154.1 6195.5 6195.5 6202.9 6177.6 6211.3 6218.8 6231.6 6241.0 4801.3 4852.5 4872.7 4890.4 4906.1 4410.6 4413.4 4426.2 4426.5 4464.7 5757.2 5781.7 5854.4 5872.1 5875.4 6122.1 6196.8 6209.3 6214.4 6284.8 5779.4 5800.8 5808.2 5820.4 5841.4 5396.5 5403.9 5434.1 5451.9 5460.0 6240.0 6244.8 6259.3 6272.4 6326.7 6250.8 6271.7 6300.3 6316.7 6340.8 6269.3 6270.2 6309.7 6345.7 6353.2 6058.4 6088.3 6102.3 6150.8 6188.4 4741.3 6260.2 6279.7 6286.5 6286.9 5954.8 6130.6 6131.0 6145.8 6161.3 5229.4 5918.0 6042.7 6054.7 6165.3 4656.7 5687.8 5867.6 5896.4 5971.4 6043.6 6075.1 6088.4 6118.8 6121.0 4887.5 4964.7 5673.7 5765.6 5812.8 02:58:00 INFO - PROCESS | 1669 | 02:58:00 INFO - PROCESS | 1669 | [#1] ext.html Cycles:180 Average:73738.50 Median:40943.99 stddev:174195.27 (425.4%) stddev-sans-first:174597.18 02:58:00 INFO - PROCESS | 1669 | Values: 514.9 520.9 526.4 537.8 543.5 37292.0 41663.0 41690.2 41696.0 41768.2 42458.0 42896.0 43018.7 43028.0 43221.8 9554.3 9572.3 9641.7 9675.7 9707.7 9549.8 9587.5 9655.9 9675.7 9688.4 8370.4 9661.1 9690.1 9707.2 9719.8 9643.0 9692.3 9693.1 9703.3 9722.8 9598.3 9667.9 9672.5 9676.5 9703.0 39631.0 39887.2 39907.0 40064.8 40225.6 3016.6 3247.9 3300.3 3377.1 3478.4 27068.2 31027.8 31074.4 31130.4 31318.1 2725.4 2833.7 2853.8 2854.3 2863.6 459533.0 461132.0 465177.0 465588.7 467204.0 32456.0 32611.3 32657.7 32671.5 32699.7 31313.4 31709.2 31843.0 34566.7 34624.0 16692.5 16719.7 16836.5 16866.2 16876.2 12787.7 12942.9 12947.3 12950.1 12962.7 16535.6 18388.6 19217.1 19346.9 19470.2 7790.5 7921.2 7948.4 7959.4 7969.9 699.7 782.2 931.3 938.0 1079.9 30213.5 31115.4 31393.8 31645.5 31762.7 968.7 986.8 1007.2 1040.7 1059.4 13833.4 16110.8 16199.4 16241.8 16481.3 697215.0 786182.0 786846.0 1019444.0 1044243.0 56097.0 62122.7 62205.1 62902.0 65723.3 1332.9 1389.9 1423.5 1429.0 1431.8 25658.5 28355.0 31582.5 31727.2 33161.8 54597.0 55311.6 55755.2 55826.4 55920.0 512008.0 513524.0 515345.0 518673.0 520792.0 44827.8 45268.5 45431.8 45785.5 45808.1 49638.5 50175.5 50544.5 51059.0 51078.0 36700.1 38828.6 41423.4 41481.0 42976.8 40379.2 40732.6 41155.4 41202.0 42645.4 32680.0 33920.5 38806.6 39830.4 39980.0 34623.8 35741.6 36440.5 36603.5 36740.6 26033.3 26402.9 27084.0 33589.5 34186.7 02:58:00 INFO - PROCESS | 1669 | 02:58:00 INFO - PROCESS | 1669 | [#2] jquery.html Cycles:180 Average:35766.17 Median:368.60 stddev:99796.93 (27074.5%) stddev-sans-first:100041.48 02:58:00 INFO - PROCESS | 1669 | Values: 360.7 376.5 380.0 384.7 394.6 19533.6 21586.8 21802.0 21815.9 22345.0 20600.5 20805.8 21592.8 21594.7 21790.5 4888.6 5665.8 5933.9 6040.5 6085.8 5943.5 5995.5 6017.7 6040.3 6094.6 6003.3 6006.0 6008.2 6175.2 6326.5 6639.7 6699.1 6750.9 6827.5 6829.2 4944.7 5002.4 5958.0 5965.5 6036.6 25275.0 25449.7 25609.0 25751.4 25775.6 2098.3 2149.6 2177.8 2219.8 2293.4 9991.9 9992.0 10050.6 10095.0 10205.9 1883.9 1899.4 1938.1 1956.2 1968.2 126722.0 130476.0 130592.0 131631.0 132131.0 9567.5 11383.2 11455.5 11520.9 11670.1 12176.2 13310.5 14074.2 14550.5 14561.5 8006.3 8421.4 8584.9 8612.1 8747.2 7061.7 8180.0 8459.9 8506.4 8636.0 3932.7 4407.7 4431.2 4495.0 4596.0 1851.2 1881.7 1912.6 1913.3 1917.9 748.4 816.8 876.8 910.9 944.4 16706.2 20822.3 21047.0 21766.8 21984.6 881.4 897.0 904.9 955.4 1002.7 10841.3 11619.1 11657.4 11667.3 11678.6 577393.0 580375.0 580417.0 610984.0 623699.5 99166.5 126397.0 135563.0 136638.0 141614.0 826.8 926.9 937.7 974.7 1001.2 19360.8 19561.2 19991.9 19997.3 19999.5 57045.1 57525.8 57980.7 60057.7 60737.4 86009.0 86641.0 87730.6 87760.1 88474.0 8008.4 8193.8 8196.3 8209.2 8349.3 12737.7 13185.9 13252.5 13428.1 13602.2 9678.3 9732.0 10420.4 11383.7 11684.8 9261.7 10237.0 10816.1 11202.0 11471.3 10983.8 11604.4 11790.5 11900.5 12005.3 7228.2 7338.7 8238.9 8327.3 8442.7 10777.0 11440.5 11597.1 11615.9 11651.8 02:58:00 INFO - PROCESS | 1669 | 02:58:00 INFO - PROCESS | 1669 | [#3] mootools.html Cycles:180 Average:5565.87 Median:5047.32 stddev:3079.79 (61.0%) stddev-sans-first:3072.34 02:58:00 INFO - PROCESS | 1669 | Values: 1377.0 1517.8 1701.6 1834.2 1858.1 7781.2 8223.7 8399.7 8683.6 8740.7 7273.2 8615.0 8627.7 8634.3 8659.0 2309.5 2330.6 2356.3 2359.6 2366.3 2331.6 2344.7 2369.7 2370.7 2374.0 2345.9 2348.2 2348.6 2371.0 2371.8 2329.7 2351.7 2353.5 2361.7 2365.3 2334.8 2336.5 2337.1 2340.6 2345.4 8592.4 8615.8 8646.3 8672.8 8681.7 5052.9 5161.3 5267.5 5271.1 5287.2 3431.1 3556.0 3585.4 3610.9 3670.0 1054.9 1081.2 1099.3 1111.3 1112.8 11153.3 11189.9 11256.0 11275.2 11276.4 4455.2 4560.1 4725.7 4727.3 4764.6 9406.9 9556.5 9584.3 9592.7 9604.6 4538.5 5050.9 5213.2 5222.5 5224.9 4324.1 4651.2 4761.1 4794.7 4809.0 3818.4 3887.4 3927.9 3956.3 3983.4 1259.2 1263.7 1269.3 1271.9 1279.8 852.8 853.5 898.3 915.5 955.6 5557.7 5607.9 5814.1 5873.6 5975.7 744.7 857.7 899.4 902.9 919.5 3803.6 3854.5 3890.2 3960.7 3998.5 10188.2 10458.3 10506.3 10551.2 10589.1 10511.9 10519.3 10521.5 10534.8 10538.2 8063.5 8184.1 8192.3 8195.9 8213.7 4832.5 5430.2 5519.9 5783.7 5796.3 8076.5 9392.9 9779.4 9801.5 9829.0 8393.4 9481.1 9909.3 9918.3 9935.0 6869.1 7103.5 7376.5 7380.5 7552.7 8293.5 8347.2 8369.7 8376.4 8387.0 6316.9 6508.2 7386.3 7406.2 7427.1 7187.8 7250.8 7267.0 7270.9 7292.7 6711.9 6773.0 6821.2 6822.0 6838.8 4847.7 4904.4 4966.7 5020.2 5035.6 4087.9 4906.2 4971.0 5043.8 5073.2 02:58:00 INFO - PROCESS | 1669 | 02:58:00 INFO - PROCESS | 1669 | [#4] prototype.html Cycles:180 Average:4601.72 Median:5134.87 stddev:1429.84 (27.8%) stddev-sans-first:1396.33 02:58:00 INFO - PROCESS | 1669 | Values: 266.2 279.1 297.5 311.2 313.9 4838.8 5234.9 5481.8 5513.3 5531.3 4765.8 4970.4 5423.5 5455.3 5467.2 3849.0 4110.4 4119.9 4172.6 4189.2 3858.4 4149.4 4190.3 4197.8 4212.6 3562.7 3964.8 4104.6 4104.8 4135.6 4104.7 4135.3 4145.4 4152.5 4153.9 3538.3 3545.3 3551.6 3561.6 3565.0 5117.3 5229.7 5249.2 5277.8 5309.8 4302.2 4371.7 4701.2 4725.3 4788.6 4552.0 4782.3 5789.9 5806.4 5821.9 3313.4 3496.6 3886.5 3894.6 3956.8 4722.6 4906.6 4956.9 5944.2 6023.7 3808.2 3962.6 3968.8 3979.8 3992.8 3496.6 3632.3 3963.1 3971.9 4043.7 4465.5 4673.9 4713.6 4719.2 4733.2 5093.3 5381.9 5458.9 5791.0 5881.8 1139.7 1179.7 1237.0 1320.2 1353.8 815.2 864.3 868.9 913.7 915.7 5355.5 5396.4 5412.2 5412.8 5462.1 5153.7 5362.2 5899.3 5928.1 5965.8 4730.5 4949.6 5064.2 5405.4 5408.2 2795.2 2884.5 3153.2 3155.3 3163.0 5181.4 5215.8 5583.5 5685.4 6199.0 5584.7 6065.3 6129.3 6138.1 6157.3 5659.8 5902.7 6274.0 6277.6 6303.1 5537.9 5683.5 5921.5 5979.4 6061.6 5295.5 5580.4 5834.3 5909.9 5914.6 5185.6 6182.2 6197.0 6204.2 6206.6 3115.6 3662.2 3960.4 3999.3 4009.3 4542.9 4866.6 5979.0 6053.4 6057.9 4720.6 4976.5 5335.5 5602.5 5777.0 4558.0 5417.2 5458.4 5664.4 5796.4 5152.4 5377.8 5529.6 5649.5 5696.0 4584.8 5046.3 5471.5 5829.8 5839.9 4928.9 5667.5 5683.8 5693.4 5704.2 02:58:00 INFO - PROCESS | 1669 | 02:58:00 INFO - PROCESS | 1669 | [#5] yui.html Cycles:180 Average:26474.83 Median:3768.34 stddev:43822.07 (1162.9%) stddev-sans-first:43902.23 02:58:00 INFO - PROCESS | 1669 | Values: 687.9 723.6 785.6 795.6 813.4 15126.2 15786.6 15934.4 15976.5 15982.4 14415.3 14419.1 14468.3 14500.6 14525.9 588.8 836.4 844.2 864.2 873.8 864.2 867.5 871.3 872.0 872.2 888.0 926.1 926.3 926.3 928.8 900.6 914.1 914.4 914.5 914.5 671.2 675.4 678.5 679.0 679.1 14692.9 14697.0 14717.9 14717.9 14746.3 14554.9 14601.5 14622.9 14669.6 14721.6 10928.7 12064.7 12475.8 12546.9 12553.2 3819.3 3848.0 4034.4 4072.0 4076.0 122239.4 122743.4 125585.0 125605.4 125757.0 11057.9 11260.0 11417.5 11458.5 11900.9 22411.3 22659.3 23041.3 23051.5 23085.4 8043.1 8081.0 8102.4 8209.9 8377.7 4468.4 4495.9 4520.4 4528.6 4673.2 3051.2 3079.8 3656.5 3717.4 3863.7 716.6 725.5 726.5 726.6 740.8 603.2 655.1 670.2 687.7 706.9 8356.8 9617.1 9733.6 9775.5 9914.7 580.2 614.8 634.1 698.6 706.4 4362.3 4568.5 4829.6 4860.6 4881.3 122110.4 146069.3 158423.0 176268.2 181134.0 107834.5 147021.0 150911.5 151448.0 152933.0 130311.3 131000.0 131262.0 132116.3 132334.0 7109.9 8427.7 9131.8 9183.7 9269.7 62039.7 64453.7 65859.0 66386.7 66872.0 77204.0 89704.6 95498.0 96645.3 98061.5 11957.4 12073.0 12256.5 12342.6 12812.7 13547.5 13720.9 13853.4 14132.2 14391.2 12737.7 12898.3 13084.7 13403.7 13504.7 12230.4 12736.5 13157.1 13160.9 13216.4 12257.6 12704.2 12706.2 13129.3 13164.8 10432.8 10864.5 11108.7 11139.3 11289.7 8621.8 9814.9 9936.2 10912.1 10915.1 02:58:00 INFO - PROCESS | 1669 | -------- Summary: end -------- 02:58:00 INFO - PROCESS | 1669 | 02:58:01 INFO - TEST-INFO | 1669: exit 0 02:58:01 INFO - TEST-OK | dromaeo_css | took 1114599ms 02:58:01 INFO - TEST-START | kraken 02:58:01 INFO - operating with platform_type : mac_ 02:58:01 INFO - Initialising browser for kraken test... 02:58:01 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmp2rENxo/profile http://localhost:49273/getInfo.html) 02:58:04 INFO - PROCESS | 1678 | __metrics Screen width/height:1600/1200 02:58:04 INFO - PROCESS | 1678 | colorDepth:24 02:58:04 INFO - PROCESS | 1678 | Browser inner width/height: 1024/689 02:58:04 INFO - PROCESS | 1678 | __metrics 02:58:04 ERROR - PROCESS | 1678 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 02:58:04 INFO - TEST-INFO | 1678: exit 0 02:58:04 INFO - Browser initialized. 02:58:04 INFO - Running cycle 1/1 for kraken test... 02:58:04 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmp2rENxo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:58:16 INFO - PROCESS | 1680 | RSS: Main: 254517248 02:58:16 INFO - PROCESS | 1680 | 02:58:19 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 02:58:20 INFO - PROCESS | 1680 | RSS: Main: 267276288 02:58:20 INFO - PROCESS | 1680 | 02:58:23 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 02:58:23 INFO - PROCESS | 1680 | RSS: Main: 275959808 02:58:23 INFO - PROCESS | 1680 | 02:58:27 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 02:58:27 INFO - PROCESS | 1680 | RSS: Main: 278990848 02:58:27 INFO - PROCESS | 1680 | 02:58:29 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 02:58:30 INFO - PROCESS | 1680 | RSS: Main: 280371200 02:58:30 INFO - PROCESS | 1680 | 02:58:32 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:58:33 INFO - PROCESS | 1680 | RSS: Main: 282066944 02:58:33 INFO - PROCESS | 1680 | 02:58:35 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 02:58:36 INFO - PROCESS | 1680 | RSS: Main: 282091520 02:58:36 INFO - PROCESS | 1680 | 02:58:39 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 02:58:40 INFO - PROCESS | 1680 | RSS: Main: 281772032 02:58:40 INFO - PROCESS | 1680 | 02:58:43 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 02:58:43 INFO - PROCESS | 1680 | RSS: Main: 282730496 02:58:43 INFO - PROCESS | 1680 | 02:58:45 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:58:46 INFO - PROCESS | 1680 | RSS: Main: 282185728 02:58:46 INFO - PROCESS | 1680 | 02:58:48 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:58:48 INFO - PROCESS | 1680 | RSS: Main: 282300416 02:58:48 INFO - PROCESS | 1680 | 02:58:51 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:58:51 INFO - PROCESS | 1680 | RSS: Main: 282611712 02:58:51 INFO - PROCESS | 1680 | 02:58:54 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:58:55 INFO - PROCESS | 1680 | RSS: Main: 282345472 02:58:55 INFO - PROCESS | 1680 | 02:58:58 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:58:59 INFO - PROCESS | 1680 | RSS: Main: 283058176 02:58:59 INFO - PROCESS | 1680 | 02:59:00 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 02:59:01 INFO - PROCESS | 1680 | RSS: Main: 283820032 02:59:01 INFO - PROCESS | 1680 | 02:59:01 INFO - PROCESS | 1680 | __start_tp_report 02:59:01 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 02:59:01 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 02:59:01 INFO - PROCESS | 1680 | |i|pagename|runs| 02:59:01 INFO - PROCESS | 1680 | |0;ai-astar;106;117;107;117;119;118;115;118;116;117 02:59:01 INFO - PROCESS | 1680 | |1;audio-beat-detection;138;108;132;158;111;135;126;123;195;114 02:59:01 INFO - PROCESS | 1680 | |2;audio-dft;263;264;206;221;196;201;200;197;199;195 02:59:01 INFO - PROCESS | 1680 | |3;audio-fft;72;86;79;143;59;61;60;68;141;50 02:59:01 INFO - PROCESS | 1680 | |4;audio-oscillator;69;69;117;79;100;102;108;98;100;143 02:59:01 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;89;87;89;88;90;86;90;90;88;86 02:59:01 INFO - PROCESS | 1680 | |6;imaging-darkroom;95;106;89;98;148;149;143;95;98;134 02:59:01 INFO - PROCESS | 1680 | |7;imaging-desaturate;91;101;94;148;150;91;94;92;92;85 02:59:01 INFO - PROCESS | 1680 | |8;json-parse-financial;56;55;54;53;58;63;84;84;49;54 02:59:01 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;79;73;71;77;73;86;79;73;65;98 02:59:01 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;77;99;106;78;89;86;80;88;75;107 02:59:01 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;138;157;133;146;156;148;140;132;140;150 02:59:01 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;173;169;170;207;236;185;215;228;168;167 02:59:01 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;68;66;71;74;70;60;64;83;95;88 02:59:01 INFO - PROCESS | 1680 | __end_tp_report 02:59:01 INFO - PROCESS | 1680 | __start_cc_report 02:59:01 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,1049 02:59:01 INFO - PROCESS | 1680 | __end_cc_report 02:59:01 INFO - PROCESS | 1680 | __startTimestamp1470477541090__endTimestamp 02:59:01 INFO - PROCESS | 1680 | 02:59:01 INFO - PROCESS | 1680 | ------- Summary: start ------- 02:59:01 INFO - PROCESS | 1680 | Number of tests: 14 02:59:01 INFO - PROCESS | 1680 | 02:59:01 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:115.00 Median:117.00 stddev:4.62 (3.9%) stddev-sans-first:3.57 02:59:01 INFO - PROCESS | 1680 | Values: 106.0 117.0 107.0 117.0 119.0 118.0 115.0 118.0 116.0 117.0 02:59:01 INFO - PROCESS | 1680 | 02:59:01 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:134.00 Median:133.50 stddev:26.05 (19.5%) stddev-sans-first:27.59 02:59:01 INFO - PROCESS | 1680 | Values: 138.0 108.0 132.0 158.0 111.0 135.0 126.0 123.0 195.0 114.0 02:59:01 INFO - PROCESS | 1680 | 02:59:01 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:214.20 Median:203.50 stddev:27.03 (13.3%) stddev-sans-first:22.17 02:59:01 INFO - PROCESS | 1680 | Values: 263.0 264.0 206.0 221.0 196.0 201.0 200.0 197.0 199.0 195.0 02:59:01 INFO - PROCESS | 1680 | 02:59:01 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:81.90 Median:64.50 stddev:33.33 (51.7%) stddev-sans-first:35.16 02:59:01 INFO - PROCESS | 1680 | Values: 72.0 86.0 79.0 143.0 59.0 61.0 60.0 68.0 141.0 50.0 02:59:01 INFO - PROCESS | 1680 | 02:59:01 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:98.50 Median:106.00 stddev:22.49 (21.2%) stddev-sans-first:21.16 02:59:01 INFO - PROCESS | 1680 | Values: 69.0 69.0 117.0 79.0 100.0 102.0 108.0 98.0 100.0 143.0 02:59:01 INFO - PROCESS | 1680 | 02:59:01 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:88.30 Median:89.00 stddev:1.57 (1.8%) stddev-sans-first:1.64 02:59:01 INFO - PROCESS | 1680 | Values: 89.0 87.0 89.0 88.0 90.0 86.0 90.0 90.0 88.0 86.0 02:59:01 INFO - PROCESS | 1680 | 02:59:01 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:115.50 Median:92.00 stddev:24.77 (26.9%) stddev-sans-first:25.14 02:59:01 INFO - PROCESS | 1680 | Values: 95.0 106.0 89.0 98.0 148.0 149.0 143.0 95.0 98.0 134.0 02:59:01 INFO - PROCESS | 1680 | 02:59:01 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:103.80 Median:91.50 stddev:24.15 (26.4%) stddev-sans-first:25.16 02:59:01 INFO - PROCESS | 1680 | Values: 91.0 101.0 94.0 148.0 150.0 91.0 94.0 92.0 92.0 85.0 02:59:01 INFO - PROCESS | 1680 | 02:59:01 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:61.00 Median:57.00 stddev:12.64 (22.2%) stddev-sans-first:13.28 02:59:01 INFO - PROCESS | 1680 | Values: 56.0 55.0 54.0 53.0 58.0 63.0 84.0 84.0 49.0 54.0 02:59:01 INFO - PROCESS | 1680 | 02:59:01 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:77.40 Median:78.00 stddev:9.17 (11.8%) stddev-sans-first:9.71 02:59:01 INFO - PROCESS | 1680 | Values: 79.0 73.0 71.0 77.0 73.0 86.0 79.0 73.0 65.0 98.0 02:59:01 INFO - PROCESS | 1680 | 02:59:01 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:83.00 stddev:11.84 (14.3%) stddev-sans-first:11.81 02:59:01 INFO - PROCESS | 1680 | Values: 77.0 99.0 106.0 78.0 89.0 86.0 80.0 88.0 75.0 107.0 02:59:01 INFO - PROCESS | 1680 | 02:59:01 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:144.00 Median:147.00 stddev:8.83 (6.0%) stddev-sans-first:9.10 02:59:01 INFO - PROCESS | 1680 | Values: 138.0 157.0 133.0 146.0 156.0 148.0 140.0 132.0 140.0 150.0 02:59:01 INFO - PROCESS | 1680 | 02:59:01 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.80 Median:196.00 stddev:27.10 (13.8%) stddev-sans-first:27.88 02:59:01 INFO - PROCESS | 1680 | Values: 173.0 169.0 170.0 207.0 236.0 185.0 215.0 228.0 168.0 167.0 02:59:01 INFO - PROCESS | 1680 | 02:59:01 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.90 Median:72.50 stddev:11.25 (15.5%) stddev-sans-first:11.73 02:59:01 INFO - PROCESS | 1680 | Values: 68.0 66.0 71.0 74.0 70.0 60.0 64.0 83.0 95.0 88.0 02:59:01 INFO - PROCESS | 1680 | -------- Summary: end -------- 02:59:01 INFO - PROCESS | 1680 | 02:59:01 INFO - TEST-INFO | 1680: exit 0 02:59:01 INFO - TEST-OK | kraken | took 60740ms 02:59:01 INFO - SUITE-END | took 1175s 02:59:02 INFO - Completed test suite (00:19:35) 02:59:02 INFO - javascript benchmark 02:59:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7361.536170689236, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2968.4656761782876, 3369.275605744766, 3382.0530251529567, 3394.2532642818587, 3434.450487921933, 4598.425196850394, 5510.752016159272, 5551.666899986004, 5573.86065348366, 5621.409751976034, 4739.763011849411, 5461.2354270402175, 5519.530839878616, 5592.356878958911, 5702.800401985931, 4956.826511072113, 5021.221710634839, 5047.47001564834, 5068.569171620398, 5265.86835329116, 5153.3558305211845, 5193.740312984354, 5201.86995325118, 5244.895102097956, 5261.026710058652, 4549.909001819961, 5068.26510156029, 5091.1854103343285, 5197.948020519784, 5222.16445368743, 5105.387353517564, 5145.897082058338, 5195.5324020837925, 5220.947790522122, 5224.138017227153, 4279.764612946286, 4284.978575107136, 4370.847020354304, 5076.060928728197, 5145.794168233266, 5442.673439593597, 5510.724463776835, 5606.859828504279, 5634.746436410372, 5647.068233741427, 6093.756249750005, 6098.786542471036, 6100.389961003909, 6113.962834745944, 6118.3146263159115, 6199.814005579839, 6235.688215589248, 6257.812265631993, 6280.869443500168, 6301.054841773725, 5703.734303532216, 5712.80005199816, 5718.399568045378, 5720.542356611461, 5769.990251705976, 4825.445073816486, 6218.875622487615, 6277.654728989858, 6279.654618995999, 6324.557280990379, 6105.145279660851, 6117.449429551361, 6120.112583675342, 6126.050462178369, 6169.753209871555, 6101.755929762849, 6115.544587952024, 6153.692315384213, 6178.505719542426, 6261.186045814015, 4909.926351104737, 6154.076888466766, 6195.473384762256, 6195.504359651217, 6202.875942481125, 6177.598456100339, 6211.2857021443115, 6218.844528886814, 6231.563790534709, 6241.0, 4801.327814106028, 4852.539008794159, 4872.731999739977, 4890.388701412324, 4906.092372911023, 4410.625096866802, 4413.426254586947, 4426.159029784395, 4426.468823741172, 4464.687471877002, 5757.193992841006, 5781.682007489544, 5854.414558544111, 5872.060470324813, 5875.41245875409, 6122.093225952662, 6196.845078873064, 6209.285932117864, 6214.40963108504, 6284.780032698834, 5779.3642699303045, 5800.796972105956, 5808.215890854681, 5820.447057529528, 5841.386654401226, 5396.541293990055, 5403.946230485018, 5434.103372943499, 5451.890962180813, 5460.0, 6239.96880015597, 6244.7814326499265, 6259.311475737574, 6272.435480806749, 6326.715297811609, 6250.812475625738, 6271.717772700331, 6300.306966233802, 6316.715747791269, 6340.778072767431, 6269.310375858743, 6270.184875966095, 6309.684515774285, 6345.714442850175, 6353.205849268841, 6058.363871793575, 6088.330283668704, 6102.307478454246, 6150.769846030722, 6188.381161883775, 4741.336212930123, 6260.248770147611, 6279.686015699288, 6286.52851036165, 6286.937130628635, 5954.791582294599, 6130.601510901777, 6130.969345153246, 6145.84635384119, 6161.291451483136, 5229.398619158694, 5917.970410148094, 6042.697865106815, 6054.697265136813, 6165.290991536031, 4656.720596764205, 5687.829365119053, 5867.589268751147, 5896.410358964069, 5971.4327138921735, 6043.576949613484, 6075.119107729266, 6088.4215999479975, 6118.847028824315, 6121.0, 4887.462379138221, 4964.726940018334, 5673.687947162945, 5765.596408251382, 5812.82561523155], "value": 5590.015826995226, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [514.8995945790572, 520.9374875014997, 526.4367127173923, 537.8359600321903, 543.50541007683, 37292.0, 41663.0, 41690.16619667605, 41695.95760105999, 41768.16463670728, 42458.0, 42896.0, 43018.70943871681, 43028.0, 43221.78389108058, 9554.283428742838, 9572.28207884408, 9641.710748677517, 9675.70972870815, 9707.660231891885, 9549.809003819953, 9587.520623968809, 9655.90344096557, 9675.70972870815, 9688.370255933378, 8370.414071015031, 9661.130498255156, 9690.127888490035, 9707.223422126248, 9719.805603887919, 9643.0, 9692.273079519064, 9693.079157480028, 9703.320767546275, 9722.805543889153, 9598.280128990284, 9667.854982175273, 9672.468014259213, 9676.467794271382, 9703.0, 39631.0, 39887.20225595501, 39907.0, 40064.79967600173, 40225.59774402277, 3016.638003439601, 3247.8538465769097, 3300.290437555937, 3377.121948293461, 3478.3738926993133, 27068.244744573134, 31027.844860775553, 31074.378512429852, 31130.377392452025, 31318.06045818629, 2725.38678797271, 2833.6741274753463, 2853.800233983622, 2854.2864283929016, 2863.5847802068583, 459533.0, 461132.0, 465177.0, 465588.68822623696, 467204.0, 32456.0, 32611.347773044406, 32657.67342326594, 32671.509927351108, 32699.673003270138, 31313.373732525222, 31709.20726981844, 31843.044708658777, 34566.65433345635, 34624.0, 16692.499225023268, 16719.665606688042, 16836.494905152864, 16866.241019154168, 16876.240569174417, 12787.744245115231, 12942.870571294166, 12947.287899165449, 12950.093493455555, 12962.67593310156, 16535.586610334838, 18388.620853436045, 19217.135228914452, 19346.903265483583, 19470.221191152195, 7790.454668173174, 7921.247481489249, 7948.443608947318, 7959.44283900133, 7969.924060251908, 699.653671432644, 782.2490409207225, 931.2968708625081, 937.962481500746, 1079.9460026998618, 30213.546796798066, 31115.377692446476, 31393.8430307847, 31645.52531712026, 31762.682373176434, 968.6561270748923, 986.7977064701719, 1007.1942446043137, 1040.7242080848582, 1059.380262546419, 13833.409157946764, 16110.838891611169, 16199.352025918832, 16241.756373654405, 16481.25834337458, 697215.0, 786182.0, 786846.0, 1019444.0, 1044243.0, 56097.0, 62122.689386552775, 62205.06692399618, 62902.0, 65723.34276657172, 1332.8667133286788, 1389.9305034748222, 1423.5088894331232, 1428.992855035718, 1431.799548063272, 25658.486830263664, 28355.0, 31582.526262105628, 31727.206819829687, 33161.77672543247, 54597.0, 55311.61720957008, 55755.16367254576, 55826.44173558213, 55920.0, 512008.0, 513524.0, 515345.0, 518673.0, 520792.0, 44827.775861120484, 45268.54731452643, 45431.772841135586, 45785.4817985014, 45808.08383832371, 49638.50361496339, 50175.49824501854, 50544.49455505545, 51059.0, 51078.0, 36700.082497937765, 38828.6117138825, 41423.37864931968, 41481.0, 42976.78511607547, 40379.19241615092, 40732.59267407288, 41155.38266926059, 41201.969950751474, 42645.36031959461, 32680.0, 33920.491192632624, 38806.61193388143, 39830.402543962446, 39980.0, 34623.82688086543, 35741.642583573834, 36440.45339319859, 36603.450948235266, 36740.63259367372, 26033.349166270993, 26402.86798565995, 27084.0, 33589.496157557165, 34186.65813341835], "value": 19908.037684610033, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.6663835951744, 376.53685966261503, 379.9753016053957, 384.724921680998, 394.64087680211014, 19533.609327813454, 21586.812725300104, 21802.0, 21815.890920545397, 22345.0, 20600.484987875272, 20805.791942080574, 21592.784072159273, 21594.676079858815, 21790.45523861904, 4888.608911287089, 5665.773369065253, 5933.910991335112, 6040.456358927696, 6085.847853803668, 5943.465088142067, 5995.460408563228, 6017.669028203447, 6040.305364883029, 6094.573379863411, 6003.279606447232, 6006.0, 6008.218931538894, 6175.197224360827, 6326.49388048955, 6639.734410623618, 6699.129113215299, 6750.864982700343, 6827.52207345486, 6829.248782633907, 4944.728039957801, 5002.424721157041, 5958.0, 5965.522758179335, 6036.63780173191, 25274.98900043996, 25449.745502544924, 25609.0, 25751.35621609456, 25775.613365799527, 2098.2551194325947, 2149.57008598281, 2177.7822217778253, 2219.8113160381386, 2293.415179129311, 9991.850122248172, 9991.950040249825, 10050.648227312082, 10095.0, 10205.897941020643, 1883.877547959392, 1899.3921944977612, 1938.1375287996848, 1956.168628332967, 1968.2422267427144, 126722.0, 130476.0, 130592.0, 131631.0, 132131.0, 9567.521623918776, 11383.203175777617, 11455.484503197376, 11520.94239528797, 11670.066394688405, 12176.208546444454, 13310.535841057475, 14074.225917574428, 14550.4907328243, 14561.490347837987, 8006.279434850891, 8421.410501264974, 8584.8712269316, 8612.052674205832, 8747.212750852454, 7061.717531298793, 8180.0, 8459.900212972274, 8506.447080939719, 8636.006859211271, 3932.744371615836, 4407.691461597721, 4431.249656385709, 4494.977525112419, 4595.954040459619, 1851.1669748612908, 1881.7459642948027, 1912.550550620603, 1913.2538310059088, 1917.9266517273795, 748.4386709967415, 816.7958010497375, 876.8202518483696, 910.9043550427242, 944.40502483435, 16706.24821883018, 20822.27122050721, 21047.0, 21766.782332176477, 21984.560308793734, 881.405051590174, 896.9506677132821, 904.9230815380766, 955.4219697083304, 1002.734275417015, 10841.349519028883, 11619.128565357632, 11657.417129143509, 11667.299962002136, 11678.591249306233, 577393.0, 580375.0, 580417.0, 610984.0, 623699.4595351288, 99166.51250231253, 126397.0, 135563.0, 136638.0, 141614.0, 826.7850358906608, 926.9258459323238, 937.7421209167397, 974.697843668465, 1001.1690297053428, 19360.8383496985, 19561.23948844554, 19991.900040499706, 19997.300094496622, 19999.500012499804, 57045.14432283602, 57525.84948301094, 57980.71009644925, 60057.69971150116, 60737.392626073175, 86009.0, 86641.0, 87730.56134719285, 87760.1223987752, 88474.0, 8008.399370047153, 8193.83612327762, 8196.303314218358, 8209.179082091981, 8349.290310323448, 12737.745245095231, 13185.868141318848, 13252.536161234311, 13428.060035797791, 13602.183868967893, 9678.322517423712, 9731.951340243253, 10420.374777513374, 11383.715407114889, 11684.766304674029, 9261.67584134552, 10237.0, 10816.08063314627, 11201.984379980913, 11471.254368466023, 10983.835242471529, 11604.419779011185, 11790.469428875549, 11900.464479098287, 12005.279683219034, 7228.168760592389, 7338.743143989935, 8238.917610823815, 8327.286823246459, 8442.746717598482, 10777.0, 11440.453459427605, 11597.07223422141, 11615.941920290683, 11651.76696466049], "value": 9667.009164247358, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1376.9793453098202, 1517.7799219113228, 1701.5661006443356, 1834.192955099756, 1858.0523932794288, 7781.182975787546, 8223.671053157874, 8399.748007559783, 8683.565821708913, 8740.694075707352, 7273.236310187433, 8614.956925215381, 8627.698030568916, 8634.26608738258, 8658.95670521648, 2309.480366917447, 2330.568844763716, 2356.3284463927785, 2359.634256690216, 2366.325597204797, 2331.62693968965, 2344.6951896253463, 2369.727481339642, 2370.727366352866, 2373.9762602373926, 2345.85924844509, 2348.2133485282366, 2348.5655153796515, 2370.9881450592725, 2371.762823717623, 2329.7087864017, 2351.7413084560685, 2353.51752890657, 2361.681173041635, 2365.2667673021333, 2334.789868911806, 2336.4859730859184, 2337.100216416675, 2340.6020976434047, 2345.39019854839, 8592.398532102756, 8615.784605384853, 8646.265067469272, 8672.826543469158, 8681.739547813575, 5052.873678158076, 5161.329027226474, 5267.47325267474, 5271.103912334874, 5287.154055351125, 3431.1079119428878, 3555.964440355615, 3585.3904836177912, 3610.9277814443826, 3669.9633003670156, 1054.8945105489465, 1081.2377274021796, 1099.3294090604725, 1111.3220935229504, 1112.7830073135742, 11153.275037122561, 11189.944050279777, 11256.043236324922, 11275.210735248536, 11276.43617819114, 4455.1980643484485, 4560.1335746208115, 4725.69282996611, 4727.338172655831, 4764.6426518011285, 9406.90593094074, 9556.522173891417, 9584.329096963145, 9592.712218633453, 9604.615815367446, 4538.523455037173, 5050.873728156826, 5213.165893457104, 5222.503862133091, 5224.895502089937, 4324.091940692427, 4651.162790697639, 4761.142994260997, 4794.688345257547, 4808.975955120202, 3818.4272359145793, 3887.416887466846, 3927.9410808837893, 3956.2680904032845, 3983.3626619740703, 1259.1626568331956, 1263.684078980255, 1269.2574843716345, 1271.8728127187208, 1279.7568461992191, 852.7910661887753, 853.5220276645099, 898.3172788680649, 915.5285028210477, 955.6273053509137, 5557.666540007613, 5607.8503906699025, 5814.06974884025, 5873.647581145145, 5975.701214939236, 744.7095632703142, 857.6508733396098, 899.4288626722079, 902.9210093937812, 919.5310391700148, 3803.5625903021505, 3854.479645247912, 3890.183061557048, 3960.7227494075714, 3998.540167880731, 10188.235882308856, 10458.320209186379, 10506.317089389166, 10551.15590752738, 10589.09992650618, 10511.94744026275, 10519.26365154432, 10521.52653130611, 10534.841977370346, 10538.156947444186, 8063.516189028677, 8184.099749027602, 8192.262696357357, 8195.877061844078, 8213.671453141927, 4832.540908613676, 5430.185472179205, 5519.917201241904, 5783.681897495678, 5796.275465566804, 8076.475029123323, 9392.859107113536, 9779.364341317792, 9801.460919649202, 9828.950855245965, 8393.37049721261, 9481.146696797321, 9909.306348555532, 9918.256130790076, 9935.0, 6869.072675188786, 7103.502754807114, 7376.520526165782, 7380.483366164317, 7552.67828130064, 8293.543855088028, 8347.165283471604, 8369.707060252862, 8376.413651044368, 8386.958065209636, 6316.873662526816, 6508.153939987771, 7386.261373862786, 7406.222346653523, 7427.071616047994, 7187.820304492429, 7250.782476525713, 7266.982622432758, 7270.927290727025, 7292.744753933587, 6711.932880671131, 6773.0, 6821.2155602106395, 6822.044913712183, 6838.760643377458, 4847.733374664286, 4904.362432883702, 4966.726830024383, 5020.246962955586, 5035.59715222774, 4087.8569250076102, 4906.165951788276, 4971.0, 5043.773030213722, 5073.188289873602], "value": 4499.521047609883, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [266.22793897696675, 279.06095987003727, 297.45714071818935, 311.1567651663991, 313.87445021991203, 4838.806447742095, 5234.906037584968, 5481.835544933653, 5513.255710479084, 5531.308586426697, 4765.761711914408, 4970.4284007339165, 5423.538999185064, 5455.290812194409, 5467.20725494804, 3848.980020294624, 4110.424540564323, 4119.855805046832, 4172.603602657743, 4189.22499337622, 3858.401947698097, 4149.398337241113, 4190.308599081148, 4197.832086716543, 4212.55768144345, 3562.69717074049, 3964.83037503937, 4104.610062044101, 4104.8152833122585, 4135.607117323864, 4104.712670113093, 4135.276326642856, 4145.357469592218, 4152.522459917118, 4153.8961525961795, 3538.2569660371355, 3545.3263879862743, 3551.6093229744706, 3561.5904171020406, 3564.9821750891338, 5117.309163262949, 5229.660072095339, 5249.2388603652635, 5277.754181178586, 5309.7610607522365, 4302.182585308781, 4371.650267978586, 4701.224297990828, 4725.291206319045, 4788.6056971514245, 4552.021315417202, 4782.306565547976, 5789.942100578983, 5806.361300256968, 5821.941780582182, 3313.370459612666, 3496.5978912425144, 3886.4947556817433, 3894.6300101490315, 3956.8219430125428, 4722.574968252839, 4906.582940450066, 4956.851294461172, 5944.227250457456, 6023.668698221596, 3808.21931504041, 3962.583928687446, 3968.8093571928307, 3979.840806367713, 3992.7604343739467, 3496.5804103507744, 3632.2735452909524, 3963.147923196527, 3971.9345940111557, 4043.737157084839, 4465.486469056035, 4673.859784206479, 4713.599344055725, 4719.159527784098, 4733.171694953369, 5093.261477085802, 5381.865453363619, 5458.890822183614, 5791.044477661223, 5881.794137205177, 1139.7207684117445, 1179.7404570994368, 1236.9690757731128, 1320.2408615046386, 1353.8036984637172, 815.1807433529265, 864.338780832651, 868.9261412779985, 913.6802119258207, 915.7298596913927, 5355.464453554613, 5396.379416367168, 5412.242286079952, 5412.810551630674, 5462.098753705594, 5153.742312884341, 5362.222477740784, 5899.262592175978, 5928.0952333356345, 5965.79119730816, 4730.52694730531, 4949.604031677457, 5064.240363945364, 5405.405405405402, 5408.161734931092, 2795.2452837734104, 2884.4952133376573, 3153.243221626839, 3155.3216058547523, 3162.968370316313, 5181.445566330086, 5215.765290561933, 5583.497485226268, 5685.403032681592, 6198.969005154945, 5584.748686309126, 6065.332813390523, 6129.325774164839, 6138.1099740537375, 6157.322694503601, 5659.830205093854, 5902.704864756745, 6273.96863015682, 6277.591956522902, 6303.1175635412, 5537.944620553743, 5683.453237410138, 5921.526277897844, 5979.402059793986, 6061.575689701855, 5295.470452954673, 5580.35825880029, 5834.299884013945, 5909.940900591111, 5914.550935020948, 5185.640533557147, 6182.165407669907, 6196.977498712842, 6204.231793938706, 6206.565540412128, 3115.6417012043903, 3662.230931504307, 3960.405939109157, 3999.3201155803004, 4009.278329900646, 4542.931856022096, 4866.562009419169, 5978.953683105527, 6053.3982280543005, 6057.878842423215, 4720.622350212044, 4976.462004377721, 5335.546478549211, 5602.52378547828, 5777.0, 4558.020025694359, 5417.160340147283, 5458.399576046711, 5664.366069777573, 5796.42035796417, 5152.433232344364, 5377.821982097257, 5529.640573362719, 5649.519790817826, 5696.003199440164, 4584.793684284148, 5046.268291097844, 5471.480209380103, 5829.7959571416495, 5839.941600584109, 4928.852134435972, 5667.498112999976, 5683.77264909399, 5693.373728889902, 5704.2014118024335], "value": 4136.599695783397, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.8624275144971, 723.5947869193252, 785.603270348474, 795.6181033104107, 813.4021494201762, 15126.168060756654, 15786.605334866634, 15934.442294519695, 15976.520704378872, 15982.360705571778, 14415.279236038208, 14419.134851908893, 14468.348924298405, 14500.637484062903, 14525.92737036316, 588.8351261646725, 836.4103307168463, 844.2106630300658, 864.191980498233, 873.8208667223204, 864.2437866866492, 867.5445391169624, 871.3073106880046, 871.960761765722, 872.2062922740307, 887.9866801997975, 926.0878035135386, 926.2775035472308, 926.3376685669745, 928.8003079337941, 900.5947323704327, 914.1178762494225, 914.3690853311227, 914.4878867834001, 914.4878867834034, 671.2314400012008, 675.4326365852659, 678.4775722693498, 678.9592624442549, 679.1171477079777, 14692.926535367362, 14697.0, 14717.852821471755, 14717.92641036788, 14746.26268686572, 14554.927225363912, 14601.488947886879, 14622.853771462256, 14669.559913202622, 14721.631959201106, 10928.726781830439, 12064.698382540419, 12475.812862807064, 12546.874531254662, 12553.184043037174, 3819.312523745725, 3848.0, 4034.3545032794905, 4072.0430698785763, 4075.9810047488127, 122239.38880305631, 122743.3862830689, 125585.0, 125605.37197314046, 125757.0, 11057.889421105847, 11259.98660120593, 11417.48621312043, 11458.484368203452, 11900.880991189977, 22411.32766017022, 22659.320220393416, 23041.308760737204, 23051.538969220856, 23085.422864428187, 8043.11525732169, 8081.0, 8102.39232057598, 8209.876851847228, 8377.706780262783, 4468.374427580141, 4495.865124046284, 4520.367148599199, 4528.637708983273, 4673.205555055649, 3051.2371907023244, 3079.7690173237097, 3656.542932133483, 3717.368047431943, 3863.690904727615, 716.6273537760335, 725.5465334166146, 726.5241266970143, 726.6185252742353, 740.7888751705738, 603.2399177036965, 655.1319501660224, 670.165643773505, 687.689950644024, 706.9222385537587, 8356.78826570144, 9617.134457898683, 9733.561989710339, 9775.511224438891, 9914.702558923243, 580.2109131581046, 614.7878981751378, 634.0647544871371, 698.5599072584341, 706.4313227851526, 4362.302031674917, 4568.520305367955, 4829.589484893753, 4860.635452341088, 4881.292212629149, 122110.38944805218, 146069.3482662942, 158423.0, 176268.23731762776, 181134.0, 107834.46082769537, 147021.0, 150911.49088509195, 151448.0, 152933.0, 130311.34844325717, 131000.0, 131262.0, 132116.3394183023, 132334.0, 7109.897965815307, 8427.705030323908, 9131.77170570741, 9183.678571249975, 9269.72190834276, 62039.6898015507, 64453.67773161104, 65859.0, 66386.66806665936, 66871.99692004721, 77204.0, 89704.5514772422, 95498.0, 96645.30192282729, 98061.50969245109, 11957.393310037118, 12073.0, 12256.509739610672, 12342.629721108022, 12812.743745125232, 13547.525836595672, 13720.86279137196, 13853.445862165401, 14132.222727750073, 14391.208483533506, 12737.745245095231, 12898.290594017044, 13084.672883177996, 13403.731925361242, 13504.662383440493, 12230.44962976686, 12736.490540378281, 13157.144785588906, 13160.868391316348, 13216.405261763051, 12257.570985015482, 12704.237745735285, 12706.237625742486, 13129.277889716157, 13164.80252796228, 10432.791344173225, 10864.45677716127, 11108.722281943015, 11139.33164010162, 11289.661310160709, 8621.784455388666, 9814.938862838884, 9936.155426788515, 10912.072473839813, 10915.126789856951], "value": 7947.319868541789, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1587.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 107.0, 117.0, 119.0, 118.0, 115.0, 118.0, 116.0, 117.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 108.0, 132.0, 158.0, 111.0, 135.0, 126.0, 123.0, 195.0, 114.0], "value": 134.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [263.0, 264.0, 206.0, 221.0, 196.0, 201.0, 200.0, 197.0, 199.0, 195.0], "value": 214.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 86.0, 79.0, 143.0, 59.0, 61.0, 60.0, 68.0, 141.0, 50.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 117.0, 79.0, 100.0, 102.0, 108.0, 98.0, 100.0, 143.0], "value": 98.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 89.0, 88.0, 90.0, 86.0, 90.0, 90.0, 88.0, 86.0], "value": 88.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 106.0, 89.0, 98.0, 148.0, 149.0, 143.0, 95.0, 98.0, 134.0], "value": 115.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 101.0, 94.0, 148.0, 150.0, 91.0, 94.0, 92.0, 92.0, 85.0], "value": 103.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 53.0, 58.0, 63.0, 84.0, 84.0, 49.0, 54.0], "value": 61.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 73.0, 71.0, 77.0, 73.0, 86.0, 79.0, 73.0, 65.0, 98.0], "value": 77.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 99.0, 106.0, 78.0, 89.0, 86.0, 80.0, 88.0, 75.0, 107.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 157.0, 133.0, 146.0, 156.0, 148.0, 140.0, 132.0, 140.0, 150.0], "value": 144.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 169.0, 170.0, 207.0, 236.0, 185.0, 215.0, 228.0, 168.0, 167.0], "value": 191.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 71.0, 74.0, 70.0, 60.0, 64.0, 83.0, 95.0, 88.0], "value": 73.9, "unit": "score"}]}]} 02:59:02 INFO - Return code: 0 02:59:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:59:02 ERROR - # TBPL SUCCESS # 02:59:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:59:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:59:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:59:02 INFO - 2016-08-06 02:59:02.382 screenresolution[1685:11592] starting screenresolution argv=screenresolution get 02:59:02 INFO - 2016-08-06 02:59:02.385 screenresolution[1685:11592] Display 0: 1600x1200x32@60 02:59:02 INFO - 2016-08-06 02:59:02.391 screenresolution[1686:11595] starting screenresolution argv=screenresolution list 02:59:02 INFO - Available Modes on Display 0 02:59:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:59:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:59:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:59:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:59:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:59:02 INFO - Intel Iris: 02:59:02 INFO - Chipset Model: Intel Iris 02:59:02 INFO - Type: GPU 02:59:02 INFO - Bus: Built-In 02:59:02 INFO - VRAM (Dynamic, Max): 1536 MB 02:59:02 INFO - Vendor: Intel (0x8086) 02:59:02 INFO - Device ID: 0x0a2e 02:59:02 INFO - Revision ID: 0x0009 02:59:02 INFO - Displays: 02:59:02 INFO - Display: 02:59:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:59:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:59:02 INFO - Display Serial Number: 1600x1200 60 02:59:02 INFO - Main Display: Yes 02:59:02 INFO - Mirror: Off 02:59:02 INFO - Online: Yes 02:59:02 INFO - Rotation: Supported 02:59:02 INFO - Return code: 0 02:59:02 INFO - Running post-action listener: _resource_record_post_action 02:59:02 INFO - [mozharness: 2016-08-06 09:59:02.625644Z] Finished run-tests step (success) 02:59:02 INFO - Running post-run listener: _resource_record_post_run 02:59:02 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 31550464; Write bytes: 707465728; Read time: 317; Write time: 2036 02:59:02 INFO - TinderboxPrint: CPU usage
54.1% 02:59:02 INFO - TinderboxPrint: I/O read bytes / time
31,550,464 / 317 02:59:02 INFO - TinderboxPrint: I/O write bytes / time
707,465,728 / 2,036 02:59:02 INFO - TinderboxPrint: CPU idle
2,225.4 (45.9%) 02:59:02 INFO - TinderboxPrint: CPU system
974.8 (20.1%) 02:59:02 INFO - TinderboxPrint: CPU user
1,645.4 (34.0%) 02:59:02 INFO - TinderboxPrint: Swap in / out
435,175,424 / 0 02:59:02 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 387860992; Write bytes: 382404096; Read time: 29143; Write time: 706 02:59:02 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 30624768; Write bytes: 297675776; Read time: 303; Write time: 1278 02:59:03 INFO - Running post-run listener: _upload_blobber_files 02:59:03 INFO - Blob upload gear active. 02:59:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:59:03 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 02:59:03 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'] 02:59:03 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 02:59:03 INFO - (blobuploader) - INFO - Open directory for files ... 02:59:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:59:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:59:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:04 INFO - (blobuploader) - INFO - Done attempting. 02:59:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:59:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:59:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:05 INFO - (blobuploader) - INFO - Done attempting. 02:59:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:59:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:59:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:07 INFO - (blobuploader) - INFO - Done attempting. 02:59:07 INFO - (blobuploader) - INFO - Iteration through files over. 02:59:07 INFO - Return code: 0 02:59:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:59:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:59:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd4a1543fa98086ed7bf1d70c963a1b593b079c5ba74d4b6e49c4e7b5775fe15212a61a74069059de244cd4589b9f1c0a89d6230942129a5c0b98a4c4de747d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/697aafc615421159be69d12b497ee29e2a6e833661201a20c53937c8bb6882074a2e9998020c4baaf31798c30d38d640f9120c593170e4fec2e671ec706f9d83", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c34df37b621068740bc5e0ce150ff7885ec4f85fe4e756fad11ae1c8cdcba87ad3a6a256c477661e9720675d2ad888bf18d0dc817929bba656626cf47e91ea0b"} 02:59:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:59:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:59:07 INFO - Contents: 02:59:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd4a1543fa98086ed7bf1d70c963a1b593b079c5ba74d4b6e49c4e7b5775fe15212a61a74069059de244cd4589b9f1c0a89d6230942129a5c0b98a4c4de747d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/697aafc615421159be69d12b497ee29e2a6e833661201a20c53937c8bb6882074a2e9998020c4baaf31798c30d38d640f9120c593170e4fec2e671ec706f9d83", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c34df37b621068740bc5e0ce150ff7885ec4f85fe4e756fad11ae1c8cdcba87ad3a6a256c477661e9720675d2ad888bf18d0dc817929bba656626cf47e91ea0b"} 02:59:07 INFO - Running post-run listener: copy_logs_to_upload_dir 02:59:07 INFO - Copying logs to upload dir... 02:59:07 INFO - mkdir: /builds/slave/test/build/upload/logs 02:59:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.218190 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-08-06 02:59:07.581325) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-06 02:59:07.585208) ========= 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.JoELRjERbo/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.BThm17ybZr/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd4a1543fa98086ed7bf1d70c963a1b593b079c5ba74d4b6e49c4e7b5775fe15212a61a74069059de244cd4589b9f1c0a89d6230942129a5c0b98a4c4de747d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/697aafc615421159be69d12b497ee29e2a6e833661201a20c53937c8bb6882074a2e9998020c4baaf31798c30d38d640f9120c593170e4fec2e671ec706f9d83", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c34df37b621068740bc5e0ce150ff7885ec4f85fe4e756fad11ae1c8cdcba87ad3a6a256c477661e9720675d2ad888bf18d0dc817929bba656626cf47e91ea0b"} build_url:https://queue.taskcluster.net/v1/task/HrEATJ_oSOuhs3VuUkSrXg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010988 build_url: 'https://queue.taskcluster.net/v1/task/HrEATJ_oSOuhs3VuUkSrXg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd4a1543fa98086ed7bf1d70c963a1b593b079c5ba74d4b6e49c4e7b5775fe15212a61a74069059de244cd4589b9f1c0a89d6230942129a5c0b98a4c4de747d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/697aafc615421159be69d12b497ee29e2a6e833661201a20c53937c8bb6882074a2e9998020c4baaf31798c30d38d640f9120c593170e4fec2e671ec706f9d83", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c34df37b621068740bc5e0ce150ff7885ec4f85fe4e756fad11ae1c8cdcba87ad3a6a256c477661e9720675d2ad888bf18d0dc817929bba656626cf47e91ea0b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-06 02:59:07.622754) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 02:59:07.623112) ========= 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.JoELRjERbo/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.BThm17ybZr/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.005270 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-06 02:59:07.672698) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-06 02:59:07.673073) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-06 02:59:07.673426) ========= ========= Total master_lag: 0.28 =========