builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0061 starttime: 1470593544.79 results: success (0) buildid: 20160807080448 builduid: 256c345a0d5a4903b22f2e5a259843d4 revision: 019bbc497f9ed565fda0de3479d2b6af015f5f83 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 11:12:24.785837) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 11:12:24.786247) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 11:12:24.786520) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 11:12:24.813239) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 11:12:24.813518) ========= 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.kU2JQuM4N5/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.YVE5w49fjw/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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-07 11:12:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.19M=0.001s 2016-08-07 11:12:24 (9.19 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151313 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 11:12:24.986573) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 11:12:24.986901) ========= 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.kU2JQuM4N5/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.YVE5w49fjw/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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.020174 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 11:12:25.036018) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-07 11:12:25.036366) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 019bbc497f9ed565fda0de3479d2b6af015f5f83 --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 019bbc497f9ed565fda0de3479d2b6af015f5f83 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kU2JQuM4N5/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.YVE5w49fjw/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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-07 11:12:25,112 truncating revision to first 12 chars 2016-08-07 11:12:25,112 Setting DEBUG logging. 2016-08-07 11:12:25,112 attempt 1/10 2016-08-07 11:12:25,112 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/019bbc497f9e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-07 11:12:26,161 unpacking tar archive at: fx-team-019bbc497f9e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.320386 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-07 11:12:26.379478) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 11:12:26.379766) ========= script_repo_revision: 019bbc497f9ed565fda0de3479d2b6af015f5f83 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 11:12:26.380131) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 11:12:26.380399) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 11:12:26.398960) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-08-07 11:12:26.399225) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kU2JQuM4N5/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.YVE5w49fjw/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 11:12:26 INFO - MultiFileLogger online at 20160807 11:12:26 in /builds/slave/test 11:12:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:12:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:12:26 INFO - {'append_to_log': False, 11:12:26 INFO - 'base_work_dir': '/builds/slave/test', 11:12:26 INFO - 'blob_upload_branch': 'Fx-Team', 11:12:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:12:26 INFO - 'branch': 'Fx-Team', 11:12:26 INFO - 'buildbot_json_path': 'buildprops.json', 11:12:26 INFO - 'config_files': ('talos/mac_config.py',), 11:12:26 INFO - 'default_actions': ('clobber', 11:12:26 INFO - 'read-buildbot-config', 11:12:26 INFO - 'download-and-extract', 11:12:26 INFO - 'populate-webroot', 11:12:26 INFO - 'create-virtualenv', 11:12:26 INFO - 'install', 11:12:26 INFO - 'run-tests'), 11:12:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:12:26 INFO - 'download_minidump_stackwalk': True, 11:12:26 INFO - 'download_symbols': 'ondemand', 11:12:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:12:26 INFO - 'tooltool.py': '/tools/tooltool.py', 11:12:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:12:26 INFO - '/tools/misc-python/virtualenv.py')}, 11:12:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:12:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:12:26 INFO - 'installer_path': 'installer.exe', 11:12:26 INFO - 'log_level': 'info', 11:12:26 INFO - 'log_name': 'talos', 11:12:26 INFO - 'log_to_console': True, 11:12:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:12:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:12:26 INFO - 'opt_config_files': (), 11:12:26 INFO - 'pip_index': False, 11:12:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:12:26 INFO - 'cmd': ('bash', 11:12:26 INFO - '-c', 11:12:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:12:26 INFO - 'enabled': True, 11:12:26 INFO - 'halt_on_failure': False, 11:12:26 INFO - 'name': 'check_screen_resolution'},), 11:12:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:12:26 INFO - 'cmd': ('bash', 11:12:26 INFO - '-c', 11:12:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:12:26 INFO - 'enabled': True, 11:12:26 INFO - 'halt_on_failure': False, 11:12:26 INFO - 'name': 'check_screen_resolution'},), 11:12:26 INFO - 'run_cmd_checks_enabled': True, 11:12:26 INFO - 'sps_profile': False, 11:12:26 INFO - 'sps_profile_interval': 0, 11:12:26 INFO - 'suite': 'dromaeojs', 11:12:26 INFO - 'system_bits': '32', 11:12:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:12:26 INFO - 'title': 't-yosemite-r7-0061', 11:12:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:12:26 INFO - 'use_talos_json': True, 11:12:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:12:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:12:26 INFO - 'work_dir': 'build'} 11:12:26 INFO - [mozharness: 2016-08-07 18:12:26.584979Z] Running clobber step. 11:12:26 INFO - Running pre-action listener: _resource_record_pre_action 11:12:26 INFO - Running main action method: clobber 11:12:26 INFO - rmtree: /builds/slave/test/build 11:12:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:12:28 INFO - Running post-action listener: _resource_record_post_action 11:12:28 INFO - [mozharness: 2016-08-07 18:12:28.279872Z] Finished clobber step (success) 11:12:28 INFO - [mozharness: 2016-08-07 18:12:28.279991Z] Running read-buildbot-config step. 11:12:28 INFO - Running pre-action listener: _resource_record_pre_action 11:12:28 INFO - Running main action method: read_buildbot_config 11:12:28 INFO - Using buildbot properties: 11:12:28 INFO - { 11:12:28 INFO - "project": "", 11:12:28 INFO - "product": "firefox", 11:12:28 INFO - "script_repo_revision": "production", 11:12:28 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 11:12:28 INFO - "repository": "", 11:12:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 11:12:28 INFO - "buildid": "20160807080448", 11:12:28 INFO - "pgo_build": "False", 11:12:28 INFO - "basedir": "/builds/slave/test", 11:12:28 INFO - "buildnumber": 127, 11:12:28 INFO - "slavename": "t-yosemite-r7-0061", 11:12:28 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 11:12:28 INFO - "platform": "yosemite_r7", 11:12:28 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 11:12:28 INFO - "branch": "fx-team", 11:12:28 INFO - "repo_path": "integration/fx-team", 11:12:28 INFO - "revision": "019bbc497f9ed565fda0de3479d2b6af015f5f83", 11:12:28 INFO - "stage_platform": "macosx64", 11:12:28 INFO - "builduid": "256c345a0d5a4903b22f2e5a259843d4", 11:12:28 INFO - "slavebuilddir": "test" 11:12:28 INFO - } 11:12:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/RzTCVvAjRRuN0vc9nXrgPw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 11:12:28 INFO - Running post-action listener: _resource_record_post_action 11:12:28 INFO - [mozharness: 2016-08-07 18:12:28.283204Z] Finished read-buildbot-config step (success) 11:12:28 INFO - [mozharness: 2016-08-07 18:12:28.283387Z] Running download-and-extract step. 11:12:28 INFO - Running pre-action listener: _resource_record_pre_action 11:12:28 INFO - Running main action method: download_and_extract 11:12:28 INFO - mkdir: /builds/slave/test/build/tests 11:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:28 INFO - trying https://queue.taskcluster.net/v1/task/RzTCVvAjRRuN0vc9nXrgPw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 11:12:28 INFO - Downloading https://queue.taskcluster.net/v1/task/RzTCVvAjRRuN0vc9nXrgPw/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 11:12:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RzTCVvAjRRuN0vc9nXrgPw/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 11:12:29 INFO - Downloaded 1199 bytes. 11:12:29 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 11:12:29 INFO - Using the following test package requirements: 11:12:29 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:12:29 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:12:29 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 11:12:29 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:12:29 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 11:12:29 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:12:29 INFO - u'jsshell-mac.zip'], 11:12:29 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:12:29 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 11:12:29 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:12:29 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:12:29 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 11:12:29 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:12:29 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 11:12:29 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:12:29 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 11:12:29 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:12:29 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 11:12:29 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:12: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')]} 11:12:29 INFO - trying https://queue.taskcluster.net/v1/task/RzTCVvAjRRuN0vc9nXrgPw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:12:29 INFO - Downloading https://queue.taskcluster.net/v1/task/RzTCVvAjRRuN0vc9nXrgPw/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 11:12:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RzTCVvAjRRuN0vc9nXrgPw/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 11:12:30 INFO - Downloaded 16324104 bytes. 11:12:30 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'] 11:12:30 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 11:12:33 INFO - Return code: 0 11:12:33 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 11:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:33 INFO - trying https://queue.taskcluster.net/v1/task/RzTCVvAjRRuN0vc9nXrgPw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:12:33 INFO - Downloading https://queue.taskcluster.net/v1/task/RzTCVvAjRRuN0vc9nXrgPw/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 11:12:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RzTCVvAjRRuN0vc9nXrgPw/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 11:12:35 INFO - Downloaded 16324104 bytes. 11:12:35 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'] 11:12:35 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 11:12:39 INFO - Return code: 0 11:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:39 INFO - trying https://queue.taskcluster.net/v1/task/RzTCVvAjRRuN0vc9nXrgPw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 11:12:39 INFO - Downloading https://queue.taskcluster.net/v1/task/RzTCVvAjRRuN0vc9nXrgPw/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 11:12:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RzTCVvAjRRuN0vc9nXrgPw/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 11:12:40 INFO - Downloaded 14413723 bytes. 11:12:40 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'] 11:12:40 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 11:12:40 INFO - Return code: 0 11:12: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')]} 11:12:40 INFO - trying https://queue.taskcluster.net/v1/task/RzTCVvAjRRuN0vc9nXrgPw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:12:40 INFO - Downloading https://queue.taskcluster.net/v1/task/RzTCVvAjRRuN0vc9nXrgPw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 11:12:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RzTCVvAjRRuN0vc9nXrgPw/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 11:12:43 INFO - Downloaded 111872295 bytes. 11:12:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RzTCVvAjRRuN0vc9nXrgPw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:12:43 INFO - mkdir: /builds/slave/test/properties 11:12:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:12:43 INFO - Writing to file /builds/slave/test/properties/build_url 11:12:43 INFO - Contents: 11:12:43 INFO - build_url:https://queue.taskcluster.net/v1/task/RzTCVvAjRRuN0vc9nXrgPw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:12:44 INFO - Running post-action listener: _resource_record_post_action 11:12:44 INFO - Running post-action listener: set_extra_try_arguments 11:12:44 INFO - [mozharness: 2016-08-07 18:12:44.141573Z] Finished download-and-extract step (success) 11:12:44 INFO - [mozharness: 2016-08-07 18:12:44.141731Z] Running populate-webroot step. 11:12:44 INFO - Running pre-action listener: _resource_record_pre_action 11:12:44 INFO - Running main action method: populate_webroot 11:12:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:12:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:12:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:12:44 INFO - '--tppagecycles', 11:12:44 INFO - '7'], 11:12:44 INFO - 'tests': ['tsvgm']}}, 11:12:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:12:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:12:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:12:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:12:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:12:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:12:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:44 INFO - 'talos_options': ['--disable-e10s'], 11:12:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:44 INFO - 'talos_options': ['--disable-e10s'], 11:12:44 INFO - 'tests': ['damp', 'tps']}, 11:12:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:44 INFO - 'tests': ['damp', 'tps']}, 11:12:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:12:44 INFO - 'tests': ['dromaeo_dom']}, 11:12:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:12:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:12:44 INFO - 'tests': ['basic_compositor_video']}, 11:12:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:12:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:12:44 INFO - 'tests': ['a11yr', 11:12:44 INFO - 'ts_paint', 11:12:44 INFO - 'tpaint', 11:12:44 INFO - 'sessionrestore', 11:12:44 INFO - 'sessionrestore_no_auto_restore', 11:12:44 INFO - 'tabpaint']}, 11:12:44 INFO - 'other-e10s': {'tests': ['a11yr', 11:12:44 INFO - 'ts_paint', 11:12:44 INFO - 'tpaint', 11:12:44 INFO - 'sessionrestore', 11:12:44 INFO - 'sessionrestore_no_auto_restore', 11:12:44 INFO - 'tabpaint']}, 11:12:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:12:44 INFO - 'ts_paint', 11:12:44 INFO - 'tpaint', 11:12:44 INFO - 'sessionrestore', 11:12:44 INFO - 'sessionrestore_no_auto_restore', 11:12:44 INFO - 'tabpaint']}, 11:12:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:12:44 INFO - 'ts_paint', 11:12:44 INFO - 'tpaint', 11:12:44 INFO - 'sessionrestore', 11:12:44 INFO - 'sessionrestore_no_auto_restore', 11:12:44 INFO - 'tabpaint']}, 11:12:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:12:44 INFO - 'tests': ['a11yr', 11:12:44 INFO - 'ts_paint', 11:12:44 INFO - 'tpaint', 11:12:44 INFO - 'sessionrestore', 11:12:44 INFO - 'sessionrestore_no_auto_restore', 11:12:44 INFO - 'tabpaint']}, 11:12:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:12:44 INFO - 'tests': ['a11yr', 11:12:44 INFO - 'ts_paint', 11:12:44 INFO - 'tpaint', 11:12:44 INFO - 'sessionrestore', 11:12:44 INFO - 'sessionrestore_no_auto_restore', 11:12:44 INFO - 'tabpaint']}, 11:12:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:12:44 INFO - 'tests': ['tsvgx', 11:12:44 INFO - 'tsvgr_opacity', 11:12:44 INFO - 'tart', 11:12:44 INFO - 'tscrollx', 11:12:44 INFO - 'cart']}, 11:12:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:12:44 INFO - 'tsvgr_opacity', 11:12:44 INFO - 'tart', 11:12:44 INFO - 'tscrollx', 11:12:44 INFO - 'cart']}, 11:12:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:44 INFO - 'talos_options': ['--disable-e10s'], 11:12:44 INFO - 'tests': ['tp5o']}, 11:12:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:44 INFO - 'tests': ['tp5o']}, 11:12:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:44 INFO - 'talos_options': ['--disable-e10s', 11:12:44 INFO - '--xperf_path', 11:12:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:44 INFO - 'tests': ['tp5n']}, 11:12:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:44 INFO - 'talos_options': ['--xperf_path', 11:12:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:44 INFO - 'tests': ['tp5n']}}, 11:12:44 INFO - 'talos.zip': {'path': '', 11:12:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:12:44 INFO - Running post-action listener: _resource_record_post_action 11:12:44 INFO - [mozharness: 2016-08-07 18:12:44.160800Z] Finished populate-webroot step (success) 11:12:44 INFO - [mozharness: 2016-08-07 18:12:44.160910Z] Running create-virtualenv step. 11:12:44 INFO - Running pre-action listener: _resource_record_pre_action 11:12:44 INFO - Running main action method: create_virtualenv 11:12:44 INFO - Creating virtualenv /builds/slave/test/build/venv 11:12:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:12:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:12:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:12:44 INFO - Using real prefix '/tools/python27' 11:12:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:12:45 INFO - Installing distribute.............................................................................................................................................................................................done. 11:12:47 INFO - Installing pip.................done. 11:12:47 INFO - Return code: 0 11:12:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:12:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:47 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 0x10ab9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac34618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9253d975a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab03d30>, '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 0x10a868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aafbb20>, '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.kU2JQuM4N5/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.YVE5w49fjw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:12:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:12:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:12:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kU2JQuM4N5/Render', 11:12:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:47 INFO - 'HOME': '/Users/cltbld', 11:12:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:47 INFO - 'LOGNAME': 'cltbld', 11:12:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:47 INFO - 'MOZ_NO_REMOTE': '1', 11:12:47 INFO - 'NO_EM_RESTART': '1', 11:12:47 INFO - 'PAGER': '/bin/cat', 11:12:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:47 INFO - 'PWD': '/builds/slave/test', 11:12:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:47 INFO - 'SHELL': '/bin/bash', 11:12:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YVE5w49fjw/Listeners', 11:12:47 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 11:12:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:47 INFO - 'USER': 'cltbld', 11:12:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:47 INFO - 'XPC_FLAGS': '0x0', 11:12:47 INFO - 'XPC_SERVICE_NAME': '0', 11:12:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:12:48 INFO - Cleaning up... 11:12:48 INFO - Return code: 0 11:12:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ab9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac34618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9253d975a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab03d30>, '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 0x10a868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aafbb20>, '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.kU2JQuM4N5/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.YVE5w49fjw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:12:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:12:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kU2JQuM4N5/Render', 11:12:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:48 INFO - 'HOME': '/Users/cltbld', 11:12:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:48 INFO - 'LOGNAME': 'cltbld', 11:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:48 INFO - 'MOZ_NO_REMOTE': '1', 11:12:48 INFO - 'NO_EM_RESTART': '1', 11:12:48 INFO - 'PAGER': '/bin/cat', 11:12:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:48 INFO - 'PWD': '/builds/slave/test', 11:12:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:48 INFO - 'SHELL': '/bin/bash', 11:12:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YVE5w49fjw/Listeners', 11:12:48 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 11:12:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:48 INFO - 'USER': 'cltbld', 11:12:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:48 INFO - 'XPC_FLAGS': '0x0', 11:12:48 INFO - 'XPC_SERVICE_NAME': '0', 11:12:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:48 INFO - Downloading/unpacking psutil>=3.1.1 11:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:12:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:12:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:12:51 INFO - Installing collected packages: psutil 11:12:51 INFO - Running setup.py install for psutil 11:12:51 INFO - building 'psutil._psutil_osx' extension 11:12:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 11:12:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 11:12:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 11:12:51 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 11:12:51 INFO - building 'psutil._psutil_posix' extension 11:12:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 11:12:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:12:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:12:52 INFO - ^ 11:12:52 INFO - 1 warning generated. 11:12:52 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 11:12:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:12:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:12:52 INFO - Successfully installed psutil 11:12:52 INFO - Cleaning up... 11:12:52 INFO - Return code: 0 11:12:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac34618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9253d975a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab03d30>, '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 0x10a868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aafbb20>, '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.kU2JQuM4N5/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.YVE5w49fjw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:12:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:12:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kU2JQuM4N5/Render', 11:12:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:52 INFO - 'HOME': '/Users/cltbld', 11:12:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:52 INFO - 'LOGNAME': 'cltbld', 11:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:52 INFO - 'MOZ_NO_REMOTE': '1', 11:12:52 INFO - 'NO_EM_RESTART': '1', 11:12:52 INFO - 'PAGER': '/bin/cat', 11:12:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:52 INFO - 'PWD': '/builds/slave/test', 11:12:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:52 INFO - 'SHELL': '/bin/bash', 11:12:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YVE5w49fjw/Listeners', 11:12:52 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 11:12:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:52 INFO - 'USER': 'cltbld', 11:12:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:52 INFO - 'XPC_FLAGS': '0x0', 11:12:52 INFO - 'XPC_SERVICE_NAME': '0', 11:12:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:12:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:12:55 INFO - Installing collected packages: mozsystemmonitor 11:12:55 INFO - Running setup.py install for mozsystemmonitor 11:12:55 INFO - Successfully installed mozsystemmonitor 11:12:55 INFO - Cleaning up... 11:12:55 INFO - Return code: 0 11:12:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:55 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 0x10ab9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac34618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9253d975a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab03d30>, '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 0x10a868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aafbb20>, '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.kU2JQuM4N5/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.YVE5w49fjw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:12:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:12:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kU2JQuM4N5/Render', 11:12:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:55 INFO - 'HOME': '/Users/cltbld', 11:12:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:55 INFO - 'LOGNAME': 'cltbld', 11:12:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:55 INFO - 'MOZ_NO_REMOTE': '1', 11:12:55 INFO - 'NO_EM_RESTART': '1', 11:12:55 INFO - 'PAGER': '/bin/cat', 11:12:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:55 INFO - 'PWD': '/builds/slave/test', 11:12:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:55 INFO - 'SHELL': '/bin/bash', 11:12:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YVE5w49fjw/Listeners', 11:12:55 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 11:12:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:55 INFO - 'USER': 'cltbld', 11:12:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:55 INFO - 'XPC_FLAGS': '0x0', 11:12:55 INFO - 'XPC_SERVICE_NAME': '0', 11:12:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:55 INFO - Downloading/unpacking jsonschema==2.5.1 11:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:12:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:58 INFO - Downloading functools32-3.2.3-2.tar.gz 11:12:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:12:58 INFO - warning: no files found matching '*.txt' 11:12:58 INFO - no previously-included directories found matching 'build' 11:12:58 INFO - no previously-included directories found matching 'dist' 11:12:58 INFO - no previously-included directories found matching '.git*' 11:12:58 INFO - Installing collected packages: jsonschema, functools32 11:12:58 INFO - Running setup.py install for functools32 11:12:58 INFO - warning: no files found matching '*.txt' 11:12:58 INFO - no previously-included directories found matching 'build' 11:12:58 INFO - no previously-included directories found matching 'dist' 11:12:58 INFO - no previously-included directories found matching '.git*' 11:12:58 INFO - Successfully installed jsonschema functools32 11:12:58 INFO - Cleaning up... 11:12:58 INFO - Return code: 0 11:12:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:58 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 0x10ab9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac34618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9253d975a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab03d30>, '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 0x10a868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aafbb20>, '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.kU2JQuM4N5/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.YVE5w49fjw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:12:58 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 11:12:58 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 11:12:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kU2JQuM4N5/Render', 11:12:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:58 INFO - 'HOME': '/Users/cltbld', 11:12:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:58 INFO - 'LOGNAME': 'cltbld', 11:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:58 INFO - 'MOZ_NO_REMOTE': '1', 11:12:58 INFO - 'NO_EM_RESTART': '1', 11:12:58 INFO - 'PAGER': '/bin/cat', 11:12:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:58 INFO - 'PWD': '/builds/slave/test', 11:12:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:58 INFO - 'SHELL': '/bin/bash', 11:12:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YVE5w49fjw/Listeners', 11:12:58 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 11:12:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:58 INFO - 'USER': 'cltbld', 11:12:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:58 INFO - 'XPC_FLAGS': '0x0', 11:12:58 INFO - 'XPC_SERVICE_NAME': '0', 11:12:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:12:59 INFO - Cleaning up... 11:12:59 INFO - Return code: 0 11:12:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:12:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:59 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 0x10ab9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac34618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9253d975a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab03d30>, '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 0x10a868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aafbb20>, '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.kU2JQuM4N5/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.YVE5w49fjw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:12:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:12:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:12:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kU2JQuM4N5/Render', 11:12:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:12:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:12:59 INFO - 'HOME': '/Users/cltbld', 11:12:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:12:59 INFO - 'LOGNAME': 'cltbld', 11:12:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:59 INFO - 'MOZ_NO_REMOTE': '1', 11:12:59 INFO - 'NO_EM_RESTART': '1', 11:12:59 INFO - 'PAGER': '/bin/cat', 11:12:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:12:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:59 INFO - 'PWD': '/builds/slave/test', 11:12:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:12:59 INFO - 'SHELL': '/bin/bash', 11:12:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YVE5w49fjw/Listeners', 11:12:59 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 11:12:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:12:59 INFO - 'USER': 'cltbld', 11:12:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:12:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:12:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:59 INFO - 'XPC_FLAGS': '0x0', 11:12:59 INFO - 'XPC_SERVICE_NAME': '0', 11:12:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:12:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:59 INFO - Downloading/unpacking blobuploader==1.2.4 11:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:01 INFO - Downloading blobuploader-1.2.4.tar.gz 11:13:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:13:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:13:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:02 INFO - Downloading docopt-0.6.1.tar.gz 11:13:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:13:03 INFO - Installing collected packages: blobuploader, requests, docopt 11:13:03 INFO - Running setup.py install for blobuploader 11:13:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:13:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:13:03 INFO - Running setup.py install for requests 11:13:03 INFO - Running setup.py install for docopt 11:13:03 INFO - Successfully installed blobuploader requests docopt 11:13:03 INFO - Cleaning up... 11:13:04 INFO - Return code: 0 11:13:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:04 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 0x10ab9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac34618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9253d975a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab03d30>, '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 0x10a868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aafbb20>, '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.kU2JQuM4N5/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.YVE5w49fjw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:13:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:13:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kU2JQuM4N5/Render', 11:13:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:13:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:13:04 INFO - 'HOME': '/Users/cltbld', 11:13:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:13:04 INFO - 'LOGNAME': 'cltbld', 11:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:04 INFO - 'MOZ_NO_REMOTE': '1', 11:13:04 INFO - 'NO_EM_RESTART': '1', 11:13:04 INFO - 'PAGER': '/bin/cat', 11:13:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:04 INFO - 'PWD': '/builds/slave/test', 11:13:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:13:04 INFO - 'SHELL': '/bin/bash', 11:13:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YVE5w49fjw/Listeners', 11:13:04 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 11:13:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:13:04 INFO - 'USER': 'cltbld', 11:13:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:13:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:04 INFO - 'XPC_FLAGS': '0x0', 11:13:04 INFO - 'XPC_SERVICE_NAME': '0', 11:13:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:13:04 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-9kTeSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:13:04 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-6ZOjdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:13:04 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-PqBJ4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:13:04 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-1srCUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:13:04 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-DaVKn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:13:04 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-Tukj9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:13:04 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-UGRHsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:13:05 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-oNifDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:13:05 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-3126qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:13:05 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-wHhpSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:13:05 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-HKkXpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:13:05 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-SxJh5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:13:05 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-rvipzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:13:05 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-d6lPOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:05 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-Lf_VBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:13:05 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-W5Ksp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:13:05 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-LbTAOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:13:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:13:06 INFO - Running setup.py install for manifestparser 11:13:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:13:06 INFO - Running setup.py install for mozcrash 11:13:06 INFO - Running setup.py install for mozdebug 11:13:06 INFO - Running setup.py install for mozdevice 11:13:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:13:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:13:06 INFO - Running setup.py install for mozfile 11:13:06 INFO - Running setup.py install for mozhttpd 11:13:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:13:06 INFO - Running setup.py install for mozinfo 11:13:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:13:07 INFO - Running setup.py install for mozInstall 11:13:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:13:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:13:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:13:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:13:07 INFO - Running setup.py install for mozleak 11:13:07 INFO - Running setup.py install for mozlog 11:13:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:13:07 INFO - Running setup.py install for moznetwork 11:13:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:13:07 INFO - Running setup.py install for mozprocess 11:13:07 INFO - Running setup.py install for mozprofile 11:13:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:13:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:13:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:13:08 INFO - Running setup.py install for mozrunner 11:13:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:13:08 INFO - Running setup.py install for mozscreenshot 11:13:08 INFO - Running setup.py install for moztest 11:13:08 INFO - Running setup.py install for mozversion 11:13:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:13:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:13:08 INFO - Cleaning up... 11:13:08 INFO - Return code: 0 11:13:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13:08 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')]} 11:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:08 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')]} 11:13:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:08 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 0x10ab9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac34618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9253d975a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab03d30>, '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 0x10a868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aafbb20>, '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.kU2JQuM4N5/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.YVE5w49fjw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:13:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:13:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:13:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kU2JQuM4N5/Render', 11:13:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:13:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:13:08 INFO - 'HOME': '/Users/cltbld', 11:13:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:13:08 INFO - 'LOGNAME': 'cltbld', 11:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:08 INFO - 'MOZ_NO_REMOTE': '1', 11:13:08 INFO - 'NO_EM_RESTART': '1', 11:13:08 INFO - 'PAGER': '/bin/cat', 11:13:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:08 INFO - 'PWD': '/builds/slave/test', 11:13:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:13:08 INFO - 'SHELL': '/bin/bash', 11:13:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YVE5w49fjw/Listeners', 11:13:08 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 11:13:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:13:08 INFO - 'USER': 'cltbld', 11:13:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:13:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:08 INFO - 'XPC_FLAGS': '0x0', 11:13:08 INFO - 'XPC_SERVICE_NAME': '0', 11:13:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:13:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:13:08 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-ij0DXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:13:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:13:09 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-5IWWfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:13:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:13:09 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-nIB54w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:13:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:13:09 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-NrXt6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:13:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:13:09 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-OhMB2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:13:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:13:09 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-EVvD05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:13:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:13:09 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-0_I2Zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:13:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:13:09 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-Tbde0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:13:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:13:09 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-d7CWnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:13:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:13:09 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-mNvMY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:13:10 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)) 11:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:13:10 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-F0a7T7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:13:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:13:10 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-SO3xIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:13:10 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)) 11:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:13:10 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-7S_IDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:13:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:13:10 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-TQiSzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:13:10 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)) 11:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:10 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-oMhQ3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:13:10 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-zPnUx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:13:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:13:10 INFO - Running setup.py (path:/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/pip-4sMm7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:13:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:13:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:13:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:13:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:13:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:13:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:13:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:13 INFO - Downloading blessings-1.6.tar.gz 11:13:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:13:13 INFO - Installing collected packages: blessings 11:13:13 INFO - Running setup.py install for blessings 11:13:13 INFO - Successfully installed blessings 11:13:13 INFO - Cleaning up... 11:13:13 INFO - Return code: 0 11:13:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:13:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:13:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:13:13 INFO - Reading from file tmpfile_stdout 11:13:13 INFO - Current package versions: 11:13:13 INFO - blessings == 1.6 11:13:13 INFO - blobuploader == 1.2.4 11:13:13 INFO - docopt == 0.6.1 11:13:13 INFO - functools32 == 3.2.3-2 11:13:13 INFO - jsonschema == 2.5.1 11:13:13 INFO - manifestparser == 1.1 11:13:13 INFO - mozInstall == 1.12 11:13:13 INFO - mozcrash == 0.17 11:13:13 INFO - mozdebug == 0.1 11:13:13 INFO - mozdevice == 0.48 11:13:13 INFO - mozfile == 1.2 11:13:13 INFO - mozhttpd == 0.7 11:13:13 INFO - mozinfo == 0.9 11:13:13 INFO - mozleak == 0.1 11:13:13 INFO - mozlog == 3.3 11:13:13 INFO - moznetwork == 0.27 11:13:13 INFO - mozprocess == 0.23 11:13:13 INFO - mozprofile == 0.28 11:13:13 INFO - mozrunner == 6.12 11:13:13 INFO - mozscreenshot == 0.1 11:13:13 INFO - mozsystemmonitor == 0.3 11:13:13 INFO - moztest == 0.7 11:13:13 INFO - mozversion == 1.4 11:13:13 INFO - psutil == 3.1.1 11:13:13 INFO - requests == 1.2.3 11:13:13 INFO - wsgiref == 0.1.2 11:13:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13:13 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')]} 11:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:13 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')]} 11:13:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:13 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 0x10ab9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac34618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9253d975a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab03d30>, '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 0x10a868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aafbb20>, '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.kU2JQuM4N5/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.YVE5w49fjw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:13:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:13:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:13:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kU2JQuM4N5/Render', 11:13:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:13:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:13:13 INFO - 'HOME': '/Users/cltbld', 11:13:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:13:13 INFO - 'LOGNAME': 'cltbld', 11:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:13 INFO - 'MOZ_NO_REMOTE': '1', 11:13:13 INFO - 'NO_EM_RESTART': '1', 11:13:13 INFO - 'PAGER': '/bin/cat', 11:13:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:13 INFO - 'PWD': '/builds/slave/test', 11:13:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:13:13 INFO - 'SHELL': '/bin/bash', 11:13:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YVE5w49fjw/Listeners', 11:13:13 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 11:13:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:13:13 INFO - 'USER': 'cltbld', 11:13:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:13:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:13 INFO - 'XPC_FLAGS': '0x0', 11:13:13 INFO - 'XPC_SERVICE_NAME': '0', 11:13:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:13:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:13:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:13:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:13:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:13:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:13:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:13:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:13:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:13:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:13:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:13:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:13:14 INFO - Cleaning up... 11:13:14 INFO - Return code: 0 11:13:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:14 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 0x10ab9fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac34618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9253d975a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab03d30>, '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 0x10a868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aafbb20>, '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.kU2JQuM4N5/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.YVE5w49fjw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:13:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:13:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:13:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kU2JQuM4N5/Render', 11:13:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:13:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:13:14 INFO - 'HOME': '/Users/cltbld', 11:13:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:13:14 INFO - 'LOGNAME': 'cltbld', 11:13:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:14 INFO - 'MOZ_NO_REMOTE': '1', 11:13:14 INFO - 'NO_EM_RESTART': '1', 11:13:14 INFO - 'PAGER': '/bin/cat', 11:13:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:13:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:14 INFO - 'PWD': '/builds/slave/test', 11:13:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:13:14 INFO - 'SHELL': '/bin/bash', 11:13:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YVE5w49fjw/Listeners', 11:13:14 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 11:13:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:13:14 INFO - 'USER': 'cltbld', 11:13:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:13:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:13:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:14 INFO - 'XPC_FLAGS': '0x0', 11:13:14 INFO - 'XPC_SERVICE_NAME': '0', 11:13:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:13:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:13:14 INFO - Cleaning up... 11:13:14 INFO - Return code: 0 11:13:14 INFO - Running post-action listener: _resource_record_post_action 11:13:14 INFO - Running post-action listener: _start_resource_monitoring 11:13:14 INFO - Starting resource monitoring. 11:13:14 INFO - [mozharness: 2016-08-07 18:13:14.462273Z] Finished create-virtualenv step (success) 11:13:14 INFO - [mozharness: 2016-08-07 18:13:14.463204Z] Running install step. 11:13:14 INFO - Running pre-action listener: _resource_record_pre_action 11:13:14 INFO - Running main action method: install 11:13:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:13:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:13:14 INFO - Reading from file tmpfile_stdout 11:13:14 INFO - Detecting whether we're running mozinstall >=1.0... 11:13:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:13:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:13:14 INFO - Reading from file tmpfile_stdout 11:13:14 INFO - Output received: 11:13:14 INFO - Usage: mozinstall [options] installer 11:13:14 INFO - Options: 11:13:14 INFO - -h, --help show this help message and exit 11:13:14 INFO - -d DEST, --destination=DEST 11:13:14 INFO - Directory to install application into. [default: 11:13:14 INFO - "/builds/slave/test"] 11:13:14 INFO - --app=APP Application being installed. [default: firefox] 11:13:14 INFO - mkdir: /builds/slave/test/build/application 11:13:14 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'] 11:13:14 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 11:13:49 INFO - Reading from file tmpfile_stdout 11:13:49 INFO - Output received: 11:13:49 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:13:49 INFO - Running post-action listener: _resource_record_post_action 11:13:49 INFO - [mozharness: 2016-08-07 18:13:49.110308Z] Finished install step (success) 11:13:49 INFO - [mozharness: 2016-08-07 18:13:49.110450Z] Running run-tests step. 11:13:49 INFO - Running pre-action listener: _resource_record_pre_action 11:13:49 INFO - Running main action method: run_tests 11:13:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:13:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:13:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:13:49 INFO - 2016-08-07 11:13:49.125 screenresolution[2000:14000] starting screenresolution argv=screenresolution get 11:13:49 INFO - 2016-08-07 11:13:49.127 screenresolution[2000:14000] Display 0: 1600x1200x32@60 11:13:49 INFO - 2016-08-07 11:13:49.133 screenresolution[2001:14002] starting screenresolution argv=screenresolution list 11:13:49 INFO - Available Modes on Display 0 11:13:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:13:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:13:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:13:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:13:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:13:49 INFO - Intel Iris: 11:13:49 INFO - Chipset Model: Intel Iris 11:13:49 INFO - Type: GPU 11:13:49 INFO - Bus: Built-In 11:13:49 INFO - VRAM (Dynamic, Max): 1536 MB 11:13:49 INFO - Vendor: Intel (0x8086) 11:13:49 INFO - Device ID: 0x0a2e 11:13:49 INFO - Revision ID: 0x0009 11:13:49 INFO - Displays: 11:13:49 INFO - Display: 11:13:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:13:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:13:49 INFO - Display Serial Number: 1600x1200 60 11:13:49 INFO - Main Display: Yes 11:13:49 INFO - Mirror: Off 11:13:49 INFO - Online: Yes 11:13:49 INFO - Rotation: Supported 11:13:49 INFO - Return code: 0 11:13:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:13:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:13:49 INFO - Python 2.7.3 11:13:49 INFO - Return code: 0 11:13:49 INFO - grabbing minidump binary from tooltool 11:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:49 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 0x10ab03d30>, '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 0x10a868db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aafbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:13:49 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:13:49 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 11:13:49 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:13:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:13:49 INFO - Return code: 0 11:13:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:13:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:13:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:13:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:13:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:13:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RzTCVvAjRRuN0vc9nXrgPw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:13:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RzTCVvAjRRuN0vc9nXrgPw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:13:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kU2JQuM4N5/Render', 11:13:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:13:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:13:49 INFO - 'HOME': '/Users/cltbld', 11:13:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:13:49 INFO - 'LOGNAME': 'cltbld', 11:13:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:13:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:13:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:49 INFO - 'MOZ_NO_REMOTE': '1', 11:13:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:13:49 INFO - 'NO_EM_RESTART': '1', 11:13:49 INFO - 'PAGER': '/bin/cat', 11:13:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:13:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:49 INFO - 'PWD': '/builds/slave/test', 11:13:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:13:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:13:49 INFO - 'SHELL': '/bin/bash', 11:13:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YVE5w49fjw/Listeners', 11:13:49 INFO - 'TMPDIR': '/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/', 11:13:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:13:49 INFO - 'USER': 'cltbld', 11:13:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:13:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:13:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:49 INFO - 'XPC_FLAGS': '0x0', 11:13:49 INFO - 'XPC_SERVICE_NAME': '0', 11:13:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:13:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RzTCVvAjRRuN0vc9nXrgPw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:13:49 INFO - mozversion application_buildid: 20160807080448 11:13:49 INFO - mozversion application_changeset: 019bbc497f9ed565fda0de3479d2b6af015f5f83 11:13:49 INFO - mozversion application_display_name: Nightly 11:13:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:13:49 INFO - mozversion application_name: Firefox 11:13:49 INFO - mozversion application_remotingname: firefox 11:13:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:13:49 INFO - mozversion application_vendor: Mozilla 11:13:49 INFO - mozversion application_version: 51.0a1 11:13:49 INFO - mozversion platform_buildid: 20160807080448 11:13:49 INFO - mozversion platform_changeset: 019bbc497f9ed565fda0de3479d2b6af015f5f83 11:13:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:13:49 INFO - mozversion platform_version: 51.0a1 11:13:49 INFO - using testdate: 1470593629 11:13:49 INFO - actual date: 1470593629 11:13:49 INFO - starting webserver on 'localhost:49397' 11:13:49 INFO - SUITE-START | Running 2 tests 11:13:49 INFO - TEST-START | dromaeo_css 11:13:49 INFO - operating with platform_type : mac_ 11:13:49 INFO - Initialising browser for dromaeo_css test... 11:13:49 INFO - TEST-INFO | started process 2011 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmphTj8az/profile http://localhost:49397/getInfo.html) 11:13:51 INFO - PROCESS | 2011 | __metrics Screen width/height:1600/1200 11:13:51 INFO - PROCESS | 2011 | colorDepth:24 11:13:51 INFO - PROCESS | 2011 | Browser inner width/height: 1024/689 11:13:51 INFO - PROCESS | 2011 | __metrics 11:13:52 INFO - PROCESS | 2011 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:13:52 INFO - PROCESS | 2011 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:13:52 INFO - TEST-INFO | 2011: exit 0 11:13:52 INFO - Browser initialized. 11:13:52 INFO - Running cycle 1/1 for dromaeo_css test... 11:13:52 INFO - TEST-INFO | started process 2013 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmphTj8az/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:14:04 INFO - PROCESS | 2013 | RSS: Main: 243449856 11:14:04 INFO - PROCESS | 2013 | 11:14:56 INFO - PROCESS | 2013 | 1470593696262 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:17:08 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49397/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49397/tests/dromaeo/cssquery-ext.html) 11:17:09 INFO - PROCESS | 2013 | RSS: Main: 370008064 11:17:09 INFO - PROCESS | 2013 | 11:20:12 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49397/tests/dromaeo/cssquery-ext.html (next: http://localhost:49397/tests/dromaeo/cssquery-jquery.html) 11:20:13 INFO - PROCESS | 2013 | RSS: Main: 386326528 11:20:13 INFO - PROCESS | 2013 | 11:23:15 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49397/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49397/tests/dromaeo/cssquery-mootools.html) 11:23:16 INFO - PROCESS | 2013 | RSS: Main: 351010816 11:23:16 INFO - PROCESS | 2013 | 11:26:18 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49397/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49397/tests/dromaeo/cssquery-prototype.html) 11:26:19 INFO - PROCESS | 2013 | RSS: Main: 371310592 11:26:19 INFO - PROCESS | 2013 | 11:29:22 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49397/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49397/tests/dromaeo/cssquery-yui.html) 11:29:23 INFO - PROCESS | 2013 | RSS: Main: 343724032 11:29:23 INFO - PROCESS | 2013 | 11:32:26 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49397/tests/dromaeo/cssquery-yui.html (next: http://localhost:49397/tests/dromaeo/cssquery-dojo.html) 11:32:26 INFO - PROCESS | 2013 | RSS: Main: 457388032 11:32:26 INFO - PROCESS | 2013 | 11:32:26 INFO - PROCESS | 2013 | __start_tp_report 11:32:26 INFO - PROCESS | 2013 | _x_x_mozilla_page_load 11:32:26 INFO - PROCESS | 2013 | _x_x_mozilla_page_load_details 11:32:26 INFO - PROCESS | 2013 | |i|pagename|runs| 11:32:26 INFO - PROCESS | 2013 | |0;dojo.html;3328.5839270091237;3335.4996750487426;3341.4653655415136;3367.545381373514;3405.046586955652;4651.883702907429;5693.544516438686;5751.194832723417;5764.221830052952;5780.595358324914;5105.336306280178;5491.780328786854;5726.083826587746;5790.942090579093;5803.738831752571;5173.974130129353;5204.687718736869;5224.164133738584;5238.60710446718;5287.603429742765;4410.2943529035365;5294.258803767476;5301.20481927712;5303.814366497173;5312.335958005249;5184.922226166611;5190.351206099238;5194.428612852602;5210.609204309692;5251.343582052244;5254.290670759437;5277.182036784305;5301.204819277101;5305.283786688786;5348.277982472356;5115.641905066647;5137.537621614073;5145.922811157836;5206.583473322125;5207.791688332462;5619.803306884281;5633.32400111985;5701.144828275792;5701.743421546041;5703.885922281531;6178.413050760216;6200.534959877982;6209.192804935375;6220.657863817488;6244.219472565929;6108.6759897029115;6170.722317495679;6202.658853763041;6246.344133865924;6246.562740608159;5950.464458198783;5954.821355359346;5985.5810093293485;5991.850203744942;6014.338422773491;5557.055300598908;6292.874142517216;6307.5269354798575;6314.778982735582;6320.209973753281;6077.8480537986015;6092.867496376233;6111.297200821873;6134.294556126013;6153.384661533811;5245.947540524546;6221.5333849961435;6253.46845518127;6258.15514905491;6274.247090349188;6117.235345581802;6165.167702360213;6171.59884607499;6197.1324014637985;6215.409536094064;6096.496448835484;6163.260408750979;6184.288806787187;6188.412100850412;6201.224846894138;4947.950520494821;4972.154733695281;4976.576990955737;4982.377202849644;5026.195808670668;4457.576530229623;4458.866234012985;4479.260921947907;4490.079533695584;4494.280915053576;5578.972105139448;5642.605017648725;5642.85892852682;5675.5459563234845;5681.801136960186;5166.870828229325;6160.845978850475;6250.093736408196;6255.43701066897;6270.2789179244055;5705.5435565154685;5705.885882282331;5711.7144142792695;5715.999700052557;5746;5392.137258038773;5448.536874365644;5454.400015998316;5454.672719636835;5466.562674985991;6159.19930409044;6176.135341052346;6222;6244.1570387997035;6256.968715156304;6241.906371404341;6273.215848018997;6286.245650521967;6289.496840252677;6293.653849038347;6177.413145751147;6248.187735594343;6284.874302513833;6287.622742635456;6291.087792270004;5252.894942101213;6110.16388879229;6114.084479019511;6137.1101190328045;6146.969265153645;6219.378062193744;6259.843503912257;6262.279837818709;6276.811695649138;6309.179806625109;6146.754129834757;6147.692615369124;6157.630542167484;6161.353057928853;6164.6917654118015;5160.716160611202;5731.3408957968695;6008.759649613967;6134.038624681799;6145.508359331154;6060.726512076225;6070.219229985294;6087.659905928906;6087.817365479043;6109.816705498843;6156.353582873913;6167.814965551041;6168.25980882297;6197.411245931629;6217.689115544295;5053;5904.468597826216;5957.940420595912;5960.314563825043;6036.396360364104 11:32:26 INFO - PROCESS | 2013 | |1;ext.html;484.96218093280373;499.6302735975377;510.9463506331837;522.932018837551;545.9344878614567;31030.53454198186;40279;41402.79298603503;41478.37782433266;41538.79230603843;42809.35785963213;43245.78377108118;43252.78373608128;43255.78372108143;43288.78355608218;9647.56585953632;9754.365966212208;9829.55766990487;9833.065858743408;9843.803123937518;9607.231421486264;9669.70990870275;9715.562799674031;9723.02769723029;9730.221582273402;9707.369021013646;9764.951175244114;9774.364666296704;9789;9792.412455252672;9705.078017588317;9766.462844543546;9773.902260977371;9775.31572789905;9786.706398808012;9712.465814380206;9749.415035097845;9761.951190244074;9764.609415623367;9803.754906127333;40800.38799418011;41175.7941210295;41268.58731412707;41322;41549.584504154875;3185.665505121975;3267.950980735291;3404.3021180657906;3457.0493114393494;3501.3347463981763;25821.612675809876;31782;32800.67199328;32868.50697239544;32887.506687399706;2853.9001134960386;3148.3703259347994;3179.3641271745514;3210.646828848825;3378.679025492574;388802;388987;389436.05281973694;389478;390984;33456.99629011133;56898.14652780211;57129.42870571324;57268.427315727145;57382.139267911014;34006.82996585001;35547;35608;35623.82188089095;35644.821775891476;14310.785338219936;14454.638634034232;14474.986750927334;14483.493077742229;14486.275686215648;12183.634490965285;12265.08011899111;12291.877081229073;12308.630741077783;12352.814707779391;5892.499137573354;6638.800835974928;7631.771046868603;7854.2145785421;7862.01724784402;3260.136063943057;3302.8348582570775;3305.454599991023;3307.503874418808;3332.7333813294877;980.3970558106713;981.2983716642635;981.8772653418323;1021.4790456867051;1024.7284469615558;25336;30359.241018974702;30912.381752364825;30915;31151.376972460876;1027.1679939249232;1033.7415646088477;1037.725002874239;1048.8007278617038;1077.3805062089173;14040;14299.285035748379;14812.81497480199;15691.293891774898;16146.75779863303;696920;703860;704245;706611;708445;58883.41116588865;59384.10923836146;59496.702516488;59510;59642;1253.3858409379338;1374.6013656039636;1386.1960063163342;1415.7380884536394;1416.992915035439;30912.845435772677;31614.36771264516;31816.68183318137;32021.519677204393;32502.862399815895;49266.75366623144;49987;50003.74998125132;50028.49971500384;50045.496815222585;538438;541487;543409;543525;543885;22084.76608958283;22097.895105244996;26439.339016523973;26758.331041724112;27577.44845103127;46835.48073296218;47757.76121119372;47904.76047619739;48412;48540.75729621329;39039;39647.40528892011;39972;40727;41263.381049283686;32310.35379292448;33959.320813583094;39145.60854391533;39295;40479.392809107296;38190.427143592315;38434.6156538431;38870.6112938867;38889;39326;28147.014854479996;29487.5256237183;32653.510197346583;34031.65968340384;34553;22793;24521;25634.615480768178;25709.35726606775;25934.610980834925 11:32:26 INFO - PROCESS | 2013 | |2;jquery.html;356.34966186709244;369.36838007008015;369.77258985723773;389.98440062397503;397.72755662371276;17478.475645730632;19884.20463181473;20474.283400081;21024.474388140305;21163.788362116375;19797.208111675514;20063.297784577542;20364.287249946217;20658.690119648218;20677.689834652454;5345.65253258537;5937.64374137552;6139.815805525819;6174.938250617482;6177.66022868742;6007.429294217064;6020.608660437079;6083;6083.117947897552;6086.300075491331;5807.332156801958;5954.13665018572;5997.37027612101;6069.302030266532;6112.969435152818;5753.252077229975;5959.165716799652;6007.429294217042;6009.4591486766185;6015.75936962521;5164.2253661950635;5217.739113044333;5218;5218.8695282617855;5230.712310822903;25529.61705574418;25567.23298301054;25581.23256302314;25622.615660765103;25886;2187.9124835006583;2220.289507357646;2491.8504889706496;2524.691083542066;2863.18399256211;13618.863811361858;14758.70482590353;15328.463503777315;15597.68804623901;16057.306819431597;1766.5583604098974;1814.129217975366;1838.8528917686554;1845.5847434327304;1894.0719047666682;119592;123924;124734;126531;127349;8480.837386466412;10375.584976601003;10930.398828064534;10931.398773067558;11074;13750;13780.448782048807;13784.379702913393;13794.517191898236;13813.861861381458;7398.260173982666;7604.505707129019;7637.541747495168;7723.884141737878;7730.149683534807;7259.963700181571;7319.011933389031;7414.740484083139;7443.255674432622;7452.143003554552;5587.944120558743;6459.450946669492;6568.277489476154;6600.339966003361;6607.108040414579;1664.4756901575965;1726.5338358643096;1749.2303386509896;1776.2539733311783;1777.5289548269718;818.9140140285303;893.6425429828121;917.8118485710413;1014.2089170447063;1020.9183265338755;17296.740548891776;21894.562108758055;21922.342329729814;21983.450413739465;22112.668309975365;933.5565606336936;951.9809603807885;959.6161535385762;977.6089564174245;981.254246772458;9502.857457138149;10778.73053173677;11699.06407487399;11714.062874969983;11717.414129293502;565148;571895;583783.1621683814;591485;592784;100007;120295.79704202845;121777;123287;123953;968.5738275158908;995.9800803984025;1009.7021378693156;1014.4876837197169;1014.8477728340661;17239.22423490921;18364.449066528025;18410.63178736391;18804.87170769758;19254;52797.94404111819;54401.72799135979;54626;55263.723681381336;56110.59723506945;71387.64306178436;74702.62648686722;76281.23718762964;78066.82899756622;79152;6754.966225168842;7821.960890195513;7887.092984306878;8104.149064348394;8114.391420643357;10682.305650132717;12701.87298127007;13020.28388438645;13137.540186093442;13172.946164307024;10952.397618131079;11237.47156889726;11329;11418;11453.484593193492;10742.19433542503;11104.222704410613;11265.436728163722;11488.770224595628;11519.308841469203;11129.276597021491;11289;11673.883261167279;11715.941420292844;11730.296182229093;7062.788116356517;7262.286775882402;7392.630368481447;7600.619969001417;7893.84212315739;9522.666706665234;10993.945030274797;11405;11529.711757206136;11531.654050378502 11:32:26 INFO - PROCESS | 2013 | |3;mootools.html;1537.0777533479913;1575.3777257983097;1784.955376115597;1908.7423197868302;1930.7683078030639;8357.540335281557;8869.86695199571;8870.733877983655;8872.290216782667;8903.821923561525;7754.767356979286;7991.001124859393;8381.748547543568;8599.742007739778;8687.478751274912;2321.7330007049154;2352.4118970257437;2355.670206171129;2359.7876191142796;2360.008796305547;2317.06159005603;2340.9297721068397;2367;2368.2539999900064;2370.6562548430466;2339.415146213447;2346.8474549154253;2360.232924299601;2363.8108951283857;2365.124903785602;2143.9785602143934;2154.9461263468384;2155.7089792878073;2156.924507642233;2156.9352919412445;2308.3421224950976;2318.7681231876845;2319.5940710375617;2320.454693147126;2322.396176993977;8712.433691810076;8760.912390876074;8820.779480513038;8832.514211718353;8834.779130521723;5127.666701664417;5280.20796880471;5285.841424757264;5299.019681358923;5300.734963251822;2916.300087978891;3014.4724673182104;3406.8466918988706;3605.513255710498;3625.274945010982;1006.713086770267;1012.8025035118155;1025.7435641089728;1026.3585259212991;1033.6588925654592;11450.484728187252;11463.484143213574;11615.245009074468;11633.883661163365;11753.000994915443;3783.432485127253;4632.25883858581;4738.336632871401;4740.928886066712;4746.501617330131;9891.159251463563;9893.505324733878;9894;9901.504924753734;9912.752181195383;5293.814716484982;5295.311609490742;5299.814506492255;5304.257403963448;5319.86700332487;4256.616904478612;4361.738295702268;4481.327800829901;4495.011097558532;4851.078295123915;3906.8437262509183;4002.5597184309704;4027.2750904836826;4027.9798601006805;4031.5766844481495;1260.6974326161655;1293.2563775828935;1297.1374036265777;1306.8562458129597;1308.9476420943247;796.6693822063894;904.9457032578066;913.8492148795374;942.6088173408097;978.5351957819978;4898.485659005824;5731.77072917087;5992.64044157352;5995.52035837132;6099.993501072362;438.56581983835775;446.15899030328063;449.1466214193059;451.6432018705186;453.7164272329794;3943.7633741975574;3948.3879998600264;4023.979880100581;4060.411240370189;4088.693347998912;10356.948215258875;10616.840747388795;10764.354138751543;10781.892181078088;10787.730306742395;10713.892861071445;10726.141908647445;10741.033307002408;10743.355398676105;10771.246012779031;7665.655045522964;8125.268725814587;8243.670253189804;8244.917550824535;8250.793730156794;5897.882042359043;6082.239720034996;6092.238470191226;6098.298695650057;6111.052786818051;9493.572789224363;9761.07269809367;9995.150412215044;10019.499025048573;10066.8489972649;9222.538873056454;9581.712548623553;9878.851817222603;9929.900700992897;10216.387016779017;7356.374708149867;7599.810004749926;7612.08654961386;7696.538207707556;7705.383569314554;8098.7165449209;8356.874646880424;8440.577971101544;8574.356923230658;8579.528125953133;7517.248275172439;7523.360514356341;7528.171901090766;7638.885416718643;7692.461527693008;7417.554946703215;7440.181580026085;7466.290702383265;7496.137944136276;7514.323710866049;6955.130608673916;7007.439404847702;7094.042304289062;7095.361417472453;7103.644817759195;4937.407511098691;4974.278729584263;5035.597152227886;5038.823641172541;5102.872428189325;4958.801647934042;4984.102861484823;5076.771545280545;5140.074786538459;5214.504622060898 11:32:26 INFO - PROCESS | 2013 | |4;prototype.html;292.2999416397726;300.90671891713566;314.7497739297259;316.4920302913822;320.78026551811996;4375.737455752649;5497.8075767348155;5512.614117011805;5541.974734674088;5690.914636280449;4486.730796152225;4874.8537543873745;5428.972855135718;5451.509364157225;5480.287562616864;4174.8121334539865;4187.476565429321;4197.16056788642;4201.1807697499;4212.578742125794;3492.842822073013;3604.981975090121;4179.017930786263;4202.138561594881;4207.978960105195;3593.389123848952;3932.4494570760116;3952.3281042222748;4135.586441355856;4167.916641667165;3584.7849129052343;4128.401381799622;4129.855455059073;4138.1103062841485;4141.91716165675;2669.878650966599;3586.0317714217276;3586.3903136466865;3589.587197472298;3622.510961020255;4457.821687132511;5215.1134307167495;5281.339832520935;5315.920261196085;5367.221752845816;4407.691461597689;4416.293393057095;4484.663650226214;4524.524924882873;4754.572088512051;4938.851834444972;5711.828645140652;5734.283214598176;5752.597318187729;5761.279840019997;3522;3836.040989752562;3969.3053715599945;3973.6356867663694;3994.3609022556543;4548.839301331874;5614.9505430517565;5868.735906884243;5989.484416545061;6196.1944947157035;3619.2942376236906;3779.848806047727;3850.4994350734787;3977.980110099431;4018.417329487208;4078.817143028548;4083.734557253769;4094.0992981544014;4102.958970410317;4110.547839737626;4435.667324950641;4575.565321294472;4606.61413860812;4623.69945953512;4762.214234651313;5423.7830486780085;5620.718964051781;5650.519705825051;5657.8019769307875;5685.545156387479;1361.2921280934056;1378.6277705019588;1381.8065470834092;1387.2439520461373;1396.2809153285862;780.4146889832625;801.3348920396057;860.9009963854237;907.2016625369632;924.9306302027375;4467.620252278528;4915.410150781858;5166.018456493254;5317.361916570037;5339.359276886798;5524.83978364548;5574.912891986024;5859.392570306173;5863.618864773776;5908.881822363529;3930.665893399036;5076.6953982760415;5126.92309615356;5265.131253343232;5455.1544510600925;2663.5072511585417;2723.9591406128925;3120.1731541141617;3128.4212420702243;3141.434541782455;5903.940960590339;6146.569740118238;6195.938040619626;6206.441420272197;6210.347913469021;6013.939860601426;6015.578909476295;6050.969745151246;6062.939370606237;6083.756649733961;5660.603757736919;5875.441833025856;6101.60339577926;6122.806052819657;6123.724432400552;4968.900621987612;5445.542080778655;5527.402121003122;5725.828225153252;5945.959457095078;5171.543516829476;5333.599980001438;5572.804951826666;5820.796272130455;5824.213731146241;5019.7239151847;5194.298769666047;5422.927503129373;5901.911471327848;6097.847553811191;3337.4326364517606;3907.9413808792324;4039.676825853866;4048.5344185417875;4075.2053349596545;5512.007838589093;5818.301803783404;5847.356790753099;5868.471837534642;5875.6203737486385;4828.8893554481965;4920.975395123001;5417.582417582417;5423.457654234545;5704.914426283692;5365.275687782256;5709.429057094258;5751.971240143773;5806.303243610793;5816.82549523515;4260.233158031584;4798.688085274446;4885.287181741973;5680.926461841481;5706.400827913009;5446.813614035834;5479.6026463592825;5716.342620598684;5782.508486778671;5783.797567085132;4982.128127577732;5631.859203519781;5643.548516118783;5651.2935883014625;5668.744906479301 11:32:26 INFO - PROCESS | 2013 | |5;yui.html;705.7424040225316;716.6810769207701;764.4381379685933;818.0142034300934;834.3408707121376;15999.200039997997;16338.34646614137;16347.83652163478;16347.918260408711;16360.918195409022;14717.632059198526;14797.038192517479;14811;14863.331150098244;14878.925605371986;694.9965250173742;714.5319815520817;720.020771750419;721.174255477478;864.1056506515741;718.5042320798658;718.5329535801744;863.654538184728;893.5889490834224;898.716904175186;927.3276874266137;939.0468674295596;939.3659279986016;943.7640589852537;945.8959514453404;944.4569372610777;944.7354740672623;944.7590864329586;944.8441007233798;946.129560804062;542.2652306125223;702.9964850175717;703.0263085626393;703.2931903437064;705.7353492440335;13181.86818131816;14322.14067155974;14327.283635818272;14433.35049922756;14438.422463101464;14109.576712698636;14573.125612463286;14575.125492470379;14685.412583496647;14856.851431485655;10511.421871797049;11272.605458808985;11650.533978640844;11786;12400.255984640951;3319.3029463812627;3890.455336252927;3902.3756199008308;4055.634992850628;4081.2449696806184;99027;111522.44238778835;113886.29170562365;116950.41524792321;117711;11355.034822040054;11426.25729327591;11493.42532873353;11513.712157196138;11520.884791152148;23982.7601723984;24391.02435902544;24432.267031989068;24437.511249774903;24481.510369792504;7932.325752311002;8077.111517733045;8246.876296855431;8355.456895301786;8360;4407.338899165151;4417.204903117406;4447.799849006802;4609.792559334771;4668.929966050512;3671.7883098577404;3736.2714270717493;3777.0934975606206;3783.281176576442;3786.5456145262747;489.5104895104895;612.1399433795524;615.5291202230297;652.4714980865514;679.6194131286495;610.6702380714364;648.8799572079181;674.3492529708855;678.6606696651675;685.239384283445;8330.142565178774;9397.201237894718;9528;9642.903570964341;9838.11456968862;646.9061986012002;662.4501663619185;694.0560837261321;699.1330749870125;701;4434.401355816924;4605.309203619484;4726.125666751662;4739.312799644033;4758.762061896891;100675;104931.4753426228;118127.8187218134;158645.51513121283;172996.54006919792;81293;142178.62570994295;144679;146233.5376646241;148656;121519.3924030392;122664;122916;123355.38322308511;123953;9107.316951228817;9126.269898407978;9223.44659320443;9265;9295.147144027353;56181.71909140428;58026.7098664504;60916.086258707044;63409;67976.98034529386;60698;72974.63512682403;78317.21682783327;85862.14137858791;87223;13434.865651343362;13453.663658408617;13728.313584320944;13820.792688109485;14102.576922692335;14195.929020354832;14919.701605968037;14982.438584584559;15331.233438327816;15595.220238988231;14015.018948673494;14024.22866742339;14337.64155896111;14600.707985840436;14829.555113346616;13804.309784510935;14284.714305714035;14330.355134018786;14479.710405792035;14832.703345933236;13508;13684.315784210949;14076.929615351857;14355.928220359248;14413.964090054802;11541.502762540747;11595.652130436101;11847.940760296487;11861.940690296493;11914.344711040976;10921;11328.716782080513;11462.598809041643;11846.763064738485;11890.46492907804 11:32:26 INFO - PROCESS | 2013 | __end_tp_report 11:32:26 INFO - PROCESS | 2013 | __start_cc_report 11:32:26 INFO - PROCESS | 2013 | _x_x_mozilla_cycle_collect,1395 11:32:26 INFO - PROCESS | 2013 | __end_cc_report 11:32:26 INFO - PROCESS | 2013 | __startTimestamp1470594746738__endTimestamp 11:32:26 INFO - PROCESS | 2013 | 11:32:26 INFO - PROCESS | 2013 | ------- Summary: start ------- 11:32:26 INFO - PROCESS | 2013 | Number of tests: 6 11:32:26 INFO - PROCESS | 2013 | 11:32:26 INFO - PROCESS | 2013 | [#0] dojo.html Cycles:165 Average:5711.80 Median:5985.58 stddev:645.02 (10.8%) stddev-sans-first:619.31 11:32:26 INFO - PROCESS | 2013 | Values: 3328.6 3335.5 3341.5 3367.5 3405.0 4651.9 5693.5 5751.2 5764.2 5780.6 5105.3 5491.8 5726.1 5790.9 5803.7 5174.0 5204.7 5224.2 5238.6 5287.6 4410.3 5294.3 5301.2 5303.8 5312.3 5184.9 5190.4 5194.4 5210.6 5251.3 5254.3 5277.2 5301.2 5305.3 5348.3 5115.6 5137.5 5145.9 5206.6 5207.8 5619.8 5633.3 5701.1 5701.7 5703.9 6178.4 6200.5 6209.2 6220.7 6244.2 6108.7 6170.7 6202.7 6246.3 6246.6 5950.5 5954.8 5985.6 5991.9 6014.3 5557.1 6292.9 6307.5 6314.8 6320.2 6077.8 6092.9 6111.3 6134.3 6153.4 5245.9 6221.5 6253.5 6258.2 6274.2 6117.2 6165.2 6171.6 6197.1 6215.4 6096.5 6163.3 6184.3 6188.4 6201.2 4948.0 4972.2 4976.6 4982.4 5026.2 4457.6 4458.9 4479.3 4490.1 4494.3 5579.0 5642.6 5642.9 5675.5 5681.8 5166.9 6160.8 6250.1 6255.4 6270.3 5705.5 5705.9 5711.7 5716.0 5746.0 5392.1 5448.5 5454.4 5454.7 5466.6 6159.2 6176.1 6222.0 6244.2 6257.0 6241.9 6273.2 6286.2 6289.5 6293.7 6177.4 6248.2 6284.9 6287.6 6291.1 5252.9 6110.2 6114.1 6137.1 6147.0 6219.4 6259.8 6262.3 6276.8 6309.2 6146.8 6147.7 6157.6 6161.4 6164.7 5160.7 5731.3 6008.8 6134.0 6145.5 6060.7 6070.2 6087.7 6087.8 6109.8 6156.4 6167.8 6168.3 6197.4 6217.7 5053.0 5904.5 5957.9 5960.3 6036.4 11:32:26 INFO - PROCESS | 2013 | 11:32:26 INFO - PROCESS | 2013 | [#1] ext.html Cycles:180 Average:66828.53 Median:215064.80 stddev:150310.95 (69.9%) stddev-sans-first:150650.08 11:32:26 INFO - PROCESS | 2013 | Values: 485.0 499.6 510.9 522.9 545.9 31030.5 40279.0 41402.8 41478.4 41538.8 42809.4 43245.8 43252.8 43255.8 43288.8 9647.6 9754.4 9829.6 9833.1 9843.8 9607.2 9669.7 9715.6 9723.0 9730.2 9707.4 9765.0 9774.4 9789.0 9792.4 9705.1 9766.5 9773.9 9775.3 9786.7 9712.5 9749.4 9762.0 9764.6 9803.8 40800.4 41175.8 41268.6 41322.0 41549.6 3185.7 3268.0 3404.3 3457.0 3501.3 25821.6 31782.0 32800.7 32868.5 32887.5 2853.9 3148.4 3179.4 3210.6 3378.7 388802.0 388987.0 389436.1 389478.0 390984.0 33457.0 56898.1 57129.4 57268.4 57382.1 34006.8 35547.0 35608.0 35623.8 35644.8 14310.8 14454.6 14475.0 14483.5 14486.3 12183.6 12265.1 12291.9 12308.6 12352.8 5892.5 6638.8 7631.8 7854.2 7862.0 3260.1 3302.8 3305.5 3307.5 3332.7 980.4 981.3 981.9 1021.5 1024.7 25336.0 30359.2 30912.4 30915.0 31151.4 1027.2 1033.7 1037.7 1048.8 1077.4 14040.0 14299.3 14812.8 15691.3 16146.8 696920.0 703860.0 704245.0 706611.0 708445.0 58883.4 59384.1 59496.7 59510.0 59642.0 1253.4 1374.6 1386.2 1415.7 1417.0 30912.8 31614.4 31816.7 32021.5 32502.9 49266.8 49987.0 50003.7 50028.5 50045.5 538438.0 541487.0 543409.0 543525.0 543885.0 22084.8 22097.9 26439.3 26758.3 27577.4 46835.5 47757.8 47904.8 48412.0 48540.8 39039.0 39647.4 39972.0 40727.0 41263.4 32310.4 33959.3 39145.6 39295.0 40479.4 38190.4 38434.6 38870.6 38889.0 39326.0 28147.0 29487.5 32653.5 34031.7 34553.0 22793.0 24521.0 25634.6 25709.4 25934.6 11:32:26 INFO - PROCESS | 2013 | 11:32:26 INFO - PROCESS | 2013 | [#2] jquery.html Cycles:180 Average:34503.43 Median:14027.15 stddev:97035.92 (691.8%) stddev-sans-first:97274.26 11:32:26 INFO - PROCESS | 2013 | Values: 356.3 369.4 369.8 390.0 397.7 17478.5 19884.2 20474.3 21024.5 21163.8 19797.2 20063.3 20364.3 20658.7 20677.7 5345.7 5937.6 6139.8 6174.9 6177.7 6007.4 6020.6 6083.0 6083.1 6086.3 5807.3 5954.1 5997.4 6069.3 6113.0 5753.3 5959.2 6007.4 6009.5 6015.8 5164.2 5217.7 5218.0 5218.9 5230.7 25529.6 25567.2 25581.2 25622.6 25886.0 2187.9 2220.3 2491.9 2524.7 2863.2 13618.9 14758.7 15328.5 15597.7 16057.3 1766.6 1814.1 1838.9 1845.6 1894.1 119592.0 123924.0 124734.0 126531.0 127349.0 8480.8 10375.6 10930.4 10931.4 11074.0 13750.0 13780.4 13784.4 13794.5 13813.9 7398.3 7604.5 7637.5 7723.9 7730.1 7260.0 7319.0 7414.7 7443.3 7452.1 5587.9 6459.5 6568.3 6600.3 6607.1 1664.5 1726.5 1749.2 1776.3 1777.5 818.9 893.6 917.8 1014.2 1020.9 17296.7 21894.6 21922.3 21983.5 22112.7 933.6 952.0 959.6 977.6 981.3 9502.9 10778.7 11699.1 11714.1 11717.4 565148.0 571895.0 583783.2 591485.0 592784.0 100007.0 120295.8 121777.0 123287.0 123953.0 968.6 996.0 1009.7 1014.5 1014.8 17239.2 18364.4 18410.6 18804.9 19254.0 52797.9 54401.7 54626.0 55263.7 56110.6 71387.6 74702.6 76281.2 78066.8 79152.0 6755.0 7822.0 7887.1 8104.1 8114.4 10682.3 12701.9 13020.3 13137.5 13172.9 10952.4 11237.5 11329.0 11418.0 11453.5 10742.2 11104.2 11265.4 11488.8 11519.3 11129.3 11289.0 11673.9 11715.9 11730.3 7062.8 7262.3 7392.6 7600.6 7893.8 9522.7 10993.9 11405.0 11529.7 11531.7 11:32:26 INFO - PROCESS | 2013 | 11:32:26 INFO - PROCESS | 2013 | [#3] mootools.html Cycles:180 Average:5675.49 Median:4966.54 stddev:3209.41 (64.6%) stddev-sans-first:3203.34 11:32:26 INFO - PROCESS | 2013 | Values: 1537.1 1575.4 1785.0 1908.7 1930.8 8357.5 8869.9 8870.7 8872.3 8903.8 7754.8 7991.0 8381.7 8599.7 8687.5 2321.7 2352.4 2355.7 2359.8 2360.0 2317.1 2340.9 2367.0 2368.3 2370.7 2339.4 2346.8 2360.2 2363.8 2365.1 2144.0 2154.9 2155.7 2156.9 2156.9 2308.3 2318.8 2319.6 2320.5 2322.4 8712.4 8760.9 8820.8 8832.5 8834.8 5127.7 5280.2 5285.8 5299.0 5300.7 2916.3 3014.5 3406.8 3605.5 3625.3 1006.7 1012.8 1025.7 1026.4 1033.7 11450.5 11463.5 11615.2 11633.9 11753.0 3783.4 4632.3 4738.3 4740.9 4746.5 9891.2 9893.5 9894.0 9901.5 9912.8 5293.8 5295.3 5299.8 5304.3 5319.9 4256.6 4361.7 4481.3 4495.0 4851.1 3906.8 4002.6 4027.3 4028.0 4031.6 1260.7 1293.3 1297.1 1306.9 1308.9 796.7 904.9 913.8 942.6 978.5 4898.5 5731.8 5992.6 5995.5 6100.0 438.6 446.2 449.1 451.6 453.7 3943.8 3948.4 4024.0 4060.4 4088.7 10356.9 10616.8 10764.4 10781.9 10787.7 10713.9 10726.1 10741.0 10743.4 10771.2 7665.7 8125.3 8243.7 8244.9 8250.8 5897.9 6082.2 6092.2 6098.3 6111.1 9493.6 9761.1 9995.2 10019.5 10066.8 9222.5 9581.7 9878.9 9929.9 10216.4 7356.4 7599.8 7612.1 7696.5 7705.4 8098.7 8356.9 8440.6 8574.4 8579.5 7517.2 7523.4 7528.2 7638.9 7692.5 7417.6 7440.2 7466.3 7496.1 7514.3 6955.1 7007.4 7094.0 7095.4 7103.6 4937.4 4974.3 5035.6 5038.8 5102.9 4958.8 4984.1 5076.8 5140.1 5214.5 11:32:26 INFO - PROCESS | 2013 | 11:32:26 INFO - PROCESS | 2013 | [#4] prototype.html Cycles:180 Average:4603.30 Median:5182.92 stddev:1427.24 (27.5%) stddev-sans-first:1394.08 11:32:26 INFO - PROCESS | 2013 | Values: 292.3 300.9 314.7 316.5 320.8 4375.7 5497.8 5512.6 5542.0 5690.9 4486.7 4874.9 5429.0 5451.5 5480.3 4174.8 4187.5 4197.2 4201.2 4212.6 3492.8 3605.0 4179.0 4202.1 4208.0 3593.4 3932.4 3952.3 4135.6 4167.9 3584.8 4128.4 4129.9 4138.1 4141.9 2669.9 3586.0 3586.4 3589.6 3622.5 4457.8 5215.1 5281.3 5315.9 5367.2 4407.7 4416.3 4484.7 4524.5 4754.6 4938.9 5711.8 5734.3 5752.6 5761.3 3522.0 3836.0 3969.3 3973.6 3994.4 4548.8 5615.0 5868.7 5989.5 6196.2 3619.3 3779.8 3850.5 3978.0 4018.4 4078.8 4083.7 4094.1 4103.0 4110.5 4435.7 4575.6 4606.6 4623.7 4762.2 5423.8 5620.7 5650.5 5657.8 5685.5 1361.3 1378.6 1381.8 1387.2 1396.3 780.4 801.3 860.9 907.2 924.9 4467.6 4915.4 5166.0 5317.4 5339.4 5524.8 5574.9 5859.4 5863.6 5908.9 3930.7 5076.7 5126.9 5265.1 5455.2 2663.5 2724.0 3120.2 3128.4 3141.4 5903.9 6146.6 6195.9 6206.4 6210.3 6013.9 6015.6 6051.0 6062.9 6083.8 5660.6 5875.4 6101.6 6122.8 6123.7 4968.9 5445.5 5527.4 5725.8 5946.0 5171.5 5333.6 5572.8 5820.8 5824.2 5019.7 5194.3 5422.9 5901.9 6097.8 3337.4 3907.9 4039.7 4048.5 4075.2 5512.0 5818.3 5847.4 5868.5 5875.6 4828.9 4921.0 5417.6 5423.5 5704.9 5365.3 5709.4 5752.0 5806.3 5816.8 4260.2 4798.7 4885.3 5680.9 5706.4 5446.8 5479.6 5716.3 5782.5 5783.8 4982.1 5631.9 5643.5 5651.3 5668.7 11:32:26 INFO - PROCESS | 2013 | 11:32:26 INFO - PROCESS | 2013 | [#5] yui.html Cycles:180 Average:24690.00 Median:3756.68 stddev:39250.42 (1044.8%) stddev-sans-first:39319.21 11:32:26 INFO - PROCESS | 2013 | Values: 705.7 716.7 764.4 818.0 834.3 15999.2 16338.3 16347.8 16347.9 16360.9 14717.6 14797.0 14811.0 14863.3 14878.9 695.0 714.5 720.0 721.2 864.1 718.5 718.5 863.7 893.6 898.7 927.3 939.0 939.4 943.8 945.9 944.5 944.7 944.8 944.8 946.1 542.3 703.0 703.0 703.3 705.7 13181.9 14322.1 14327.3 14433.4 14438.4 14109.6 14573.1 14575.1 14685.4 14856.9 10511.4 11272.6 11650.5 11786.0 12400.3 3319.3 3890.5 3902.4 4055.6 4081.2 99027.0 111522.4 113886.3 116950.4 117711.0 11355.0 11426.3 11493.4 11513.7 11520.9 23982.8 24391.0 24432.3 24437.5 24481.5 7932.3 8077.1 8246.9 8355.5 8360.0 4407.3 4417.2 4447.8 4609.8 4668.9 3671.8 3736.3 3777.1 3783.3 3786.5 489.5 612.1 615.5 652.5 679.6 610.7 648.9 674.3 678.7 685.2 8330.1 9397.2 9528.0 9642.9 9838.1 646.9 662.5 694.1 699.1 701.0 4434.4 4605.3 4726.1 4739.3 4758.8 100675.0 104931.5 118127.8 158645.5 172996.5 81293.0 142178.6 144679.0 146233.5 148656.0 121519.4 122664.0 122916.0 123355.4 123953.0 9107.3 9126.3 9223.4 9265.0 9295.1 56181.7 58026.7 60916.1 63409.0 67977.0 60698.0 72974.6 78317.2 85862.1 87223.0 13434.9 13453.7 13728.3 13820.8 14102.6 14195.9 14919.7 14982.4 15331.2 15595.2 14015.0 14024.2 14337.6 14600.7 14829.6 13804.3 14284.7 14330.4 14479.7 14832.7 13508.0 13684.3 14076.9 14355.9 14414.0 11541.5 11595.7 11847.9 11861.9 11914.3 10921.0 11328.7 11462.6 11846.8 11890.5 11:32:26 INFO - PROCESS | 2013 | -------- Summary: end -------- 11:32:26 INFO - PROCESS | 2013 | 11:32:27 INFO - TEST-INFO | 2013: exit 0 11:32:27 INFO - TEST-OK | dromaeo_css | took 1117668ms 11:32:27 INFO - TEST-START | kraken 11:32:27 INFO - operating with platform_type : mac_ 11:32:27 INFO - Initialising browser for kraken test... 11:32:27 INFO - TEST-INFO | started process 2016 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpRQs9ou/profile http://localhost:49397/getInfo.html) 11:32:29 INFO - PROCESS | 2016 | __metrics Screen width/height:1600/1200 11:32:29 INFO - PROCESS | 2016 | colorDepth:24 11:32:29 INFO - PROCESS | 2016 | Browser inner width/height: 1024/689 11:32:29 INFO - PROCESS | 2016 | __metrics 11:32:29 INFO - PROCESS | 2016 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:32:29 INFO - PROCESS | 2016 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:32:30 INFO - TEST-INFO | 2016: exit 0 11:32:30 INFO - Browser initialized. 11:32:30 INFO - Running cycle 1/1 for kraken test... 11:32:30 INFO - TEST-INFO | started process 2017 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/tmpRQs9ou/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:32:42 INFO - PROCESS | 2017 | RSS: Main: 243552256 11:32:42 INFO - PROCESS | 2017 | 11:32:44 INFO - PROCESS | 2017 | Cycle 1(1): loaded http://localhost:49397/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49397/tests/kraken/driver.html?testName=audio-beat-detection) 11:32:45 INFO - PROCESS | 2017 | RSS: Main: 294723584 11:32:45 INFO - PROCESS | 2017 | 11:32:48 INFO - PROCESS | 2017 | Cycle 1(1): loaded http://localhost:49397/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49397/tests/kraken/driver.html?testName=audio-dft) 11:32:49 INFO - PROCESS | 2017 | RSS: Main: 301903872 11:32:49 INFO - PROCESS | 2017 | 11:32:52 INFO - PROCESS | 2017 | Cycle 1(1): loaded http://localhost:49397/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49397/tests/kraken/driver.html?testName=audio-fft) 11:32:53 INFO - PROCESS | 2017 | RSS: Main: 395399168 11:32:53 INFO - PROCESS | 2017 | 11:32:55 INFO - PROCESS | 2017 | Cycle 1(1): loaded http://localhost:49397/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49397/tests/kraken/driver.html?testName=audio-oscillator) 11:32:55 INFO - PROCESS | 2017 | RSS: Main: 298582016 11:32:55 INFO - PROCESS | 2017 | 11:32:58 INFO - PROCESS | 2017 | Cycle 1(1): loaded http://localhost:49397/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49397/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:32:58 INFO - PROCESS | 2017 | RSS: Main: 301121536 11:32:58 INFO - PROCESS | 2017 | 11:33:01 INFO - PROCESS | 2017 | Cycle 1(1): loaded http://localhost:49397/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49397/tests/kraken/driver.html?testName=imaging-darkroom) 11:33:02 INFO - PROCESS | 2017 | RSS: Main: 338890752 11:33:02 INFO - PROCESS | 2017 | 11:33:05 INFO - PROCESS | 2017 | Cycle 1(1): loaded http://localhost:49397/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49397/tests/kraken/driver.html?testName=imaging-desaturate) 11:33:05 INFO - PROCESS | 2017 | RSS: Main: 339521536 11:33:05 INFO - PROCESS | 2017 | 11:33:08 INFO - PROCESS | 2017 | Cycle 1(1): loaded http://localhost:49397/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49397/tests/kraken/driver.html?testName=json-parse-financial) 11:33:09 INFO - PROCESS | 2017 | RSS: Main: 339214336 11:33:09 INFO - PROCESS | 2017 | 11:33:10 INFO - PROCESS | 2017 | Cycle 1(1): loaded http://localhost:49397/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49397/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:33:11 INFO - PROCESS | 2017 | RSS: Main: 314556416 11:33:11 INFO - PROCESS | 2017 | 11:33:13 INFO - PROCESS | 2017 | Cycle 1(1): loaded http://localhost:49397/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49397/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:33:13 INFO - PROCESS | 2017 | RSS: Main: 318169088 11:33:13 INFO - PROCESS | 2017 | 11:33:15 INFO - PROCESS | 2017 | Cycle 1(1): loaded http://localhost:49397/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49397/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:33:16 INFO - PROCESS | 2017 | RSS: Main: 319447040 11:33:16 INFO - PROCESS | 2017 | 11:33:19 INFO - PROCESS | 2017 | Cycle 1(1): loaded http://localhost:49397/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49397/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:33:20 INFO - PROCESS | 2017 | RSS: Main: 330575872 11:33:20 INFO - PROCESS | 2017 | 11:33:23 INFO - PROCESS | 2017 | Cycle 1(1): loaded http://localhost:49397/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49397/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:33:23 INFO - PROCESS | 2017 | RSS: Main: 331870208 11:33:23 INFO - PROCESS | 2017 | 11:33:25 INFO - PROCESS | 2017 | Cycle 1(1): loaded http://localhost:49397/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49397/tests/kraken/driver.html?testName=ai-astar) 11:33:25 INFO - PROCESS | 2017 | RSS: Main: 375545856 11:33:25 INFO - PROCESS | 2017 | 11:33:25 INFO - PROCESS | 2017 | __start_tp_report 11:33:25 INFO - PROCESS | 2017 | _x_x_mozilla_page_load 11:33:25 INFO - PROCESS | 2017 | _x_x_mozilla_page_load_details 11:33:25 INFO - PROCESS | 2017 | |i|pagename|runs| 11:33:25 INFO - PROCESS | 2017 | |0;ai-astar;101;112;113;112;114;114;114;114;113;112 11:33:25 INFO - PROCESS | 2017 | |1;audio-beat-detection;145;135;136;167;124;132;116;129;196;135 11:33:25 INFO - PROCESS | 2017 | |2;audio-dft;184;184;184;184;185;181;182;182;185;184 11:33:25 INFO - PROCESS | 2017 | |3;audio-fft;78;57;61;88;57;57;65;68;82;57 11:33:25 INFO - PROCESS | 2017 | |4;audio-oscillator;87;69;100;93;114;97;98;70;68;128 11:33:25 INFO - PROCESS | 2017 | |5;imaging-gaussian-blur;88;87;136;120;88;84;88;85;88;86 11:33:25 INFO - PROCESS | 2017 | |6;imaging-darkroom;93;93;94;94;94;92;93;94;93;94 11:33:25 INFO - PROCESS | 2017 | |7;imaging-desaturate;86;85;84;86;85;87;84;97;123;84 11:33:25 INFO - PROCESS | 2017 | |8;json-parse-financial;54;54;56;56;54;51;53;53;54;53 11:33:25 INFO - PROCESS | 2017 | |9;json-stringify-tinderbox;67;78;79;75;73;70;71;73;71;74 11:33:25 INFO - PROCESS | 2017 | |10;stanford-crypto-aes;83;83;83;83;82;83;85;85;82;88 11:33:25 INFO - PROCESS | 2017 | |11;stanford-crypto-ccm;138;143;166;150;136;125;146;133;126;158 11:33:25 INFO - PROCESS | 2017 | |12;stanford-crypto-pbkdf2;163;165;162;165;163;165;165;164;164;163 11:33:25 INFO - PROCESS | 2017 | |13;stanford-crypto-sha256-iterative;67;68;69;67;66;65;66;65;68;77 11:33:25 INFO - PROCESS | 2017 | __end_tp_report 11:33:25 INFO - PROCESS | 2017 | __start_cc_report 11:33:25 INFO - PROCESS | 2017 | _x_x_mozilla_cycle_collect,2081 11:33:25 INFO - PROCESS | 2017 | __end_cc_report 11:33:25 INFO - PROCESS | 2017 | __startTimestamp1470594805710__endTimestamp 11:33:25 INFO - PROCESS | 2017 | 11:33:25 INFO - PROCESS | 2017 | ------- Summary: start ------- 11:33:25 INFO - PROCESS | 2017 | Number of tests: 14 11:33:25 INFO - PROCESS | 2017 | 11:33:25 INFO - PROCESS | 2017 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.50 stddev:3.93 (3.5%) stddev-sans-first:0.93 11:33:25 INFO - PROCESS | 2017 | Values: 101.0 112.0 113.0 112.0 114.0 114.0 114.0 114.0 113.0 112.0 11:33:25 INFO - PROCESS | 2017 | 11:33:25 INFO - PROCESS | 2017 | [#1] audio-beat-detection Cycles:10 Average:141.50 Median:135.50 stddev:23.45 (17.3%) stddev-sans-first:24.84 11:33:25 INFO - PROCESS | 2017 | Values: 145.0 135.0 136.0 167.0 124.0 132.0 116.0 129.0 196.0 135.0 11:33:25 INFO - PROCESS | 2017 | 11:33:25 INFO - PROCESS | 2017 | [#2] audio-dft Cycles:10 Average:183.50 Median:184.00 stddev:1.35 (0.7%) stddev-sans-first:1.42 11:33:25 INFO - PROCESS | 2017 | Values: 184.0 184.0 184.0 184.0 185.0 181.0 182.0 182.0 185.0 184.0 11:33:25 INFO - PROCESS | 2017 | 11:33:25 INFO - PROCESS | 2017 | [#3] audio-fft Cycles:10 Average:67.00 Median:66.50 stddev:11.68 (17.6%) stddev-sans-first:11.69 11:33:25 INFO - PROCESS | 2017 | Values: 78.0 57.0 61.0 88.0 57.0 57.0 65.0 68.0 82.0 57.0 11:33:25 INFO - PROCESS | 2017 | 11:33:25 INFO - PROCESS | 2017 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:78.50 stddev:19.77 (25.2%) stddev-sans-first:20.87 11:33:25 INFO - PROCESS | 2017 | Values: 87.0 69.0 100.0 93.0 114.0 97.0 98.0 70.0 68.0 128.0 11:33:25 INFO - PROCESS | 2017 | 11:33:25 INFO - PROCESS | 2017 | [#5] imaging-gaussian-blur Cycles:10 Average:95.00 Median:87.50 stddev:17.85 (20.4%) stddev-sans-first:18.75 11:33:25 INFO - PROCESS | 2017 | Values: 88.0 87.0 136.0 120.0 88.0 84.0 88.0 85.0 88.0 86.0 11:33:25 INFO - PROCESS | 2017 | 11:33:25 INFO - PROCESS | 2017 | [#6] imaging-darkroom Cycles:10 Average:93.40 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 11:33:25 INFO - PROCESS | 2017 | Values: 93.0 93.0 94.0 94.0 94.0 92.0 93.0 94.0 93.0 94.0 11:33:25 INFO - PROCESS | 2017 | 11:33:25 INFO - PROCESS | 2017 | [#7] imaging-desaturate Cycles:10 Average:90.10 Median:85.50 stddev:12.19 (14.3%) stddev-sans-first:12.84 11:33:25 INFO - PROCESS | 2017 | Values: 86.0 85.0 84.0 86.0 85.0 87.0 84.0 97.0 123.0 84.0 11:33:25 INFO - PROCESS | 2017 | 11:33:25 INFO - PROCESS | 2017 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:1.48 (2.7%) stddev-sans-first:1.56 11:33:25 INFO - PROCESS | 2017 | Values: 54.0 54.0 56.0 56.0 54.0 51.0 53.0 53.0 54.0 53.0 11:33:25 INFO - PROCESS | 2017 | 11:33:25 INFO - PROCESS | 2017 | [#9] json-stringify-tinderbox Cycles:10 Average:73.10 Median:73.50 stddev:3.63 (4.9%) stddev-sans-first:3.11 11:33:25 INFO - PROCESS | 2017 | Values: 67.0 78.0 79.0 75.0 73.0 70.0 71.0 73.0 71.0 74.0 11:33:25 INFO - PROCESS | 2017 | 11:33:25 INFO - PROCESS | 2017 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.00 stddev:1.83 (2.2%) stddev-sans-first:1.92 11:33:25 INFO - PROCESS | 2017 | Values: 83.0 83.0 83.0 83.0 82.0 83.0 85.0 85.0 82.0 88.0 11:33:25 INFO - PROCESS | 2017 | 11:33:25 INFO - PROCESS | 2017 | [#11] stanford-crypto-ccm Cycles:10 Average:142.10 Median:144.50 stddev:13.30 (9.2%) stddev-sans-first:14.02 11:33:25 INFO - PROCESS | 2017 | Values: 138.0 143.0 166.0 150.0 136.0 125.0 146.0 133.0 126.0 158.0 11:33:25 INFO - PROCESS | 2017 | 11:33:25 INFO - PROCESS | 2017 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.90 Median:164.50 stddev:1.10 (0.7%) stddev-sans-first:1.12 11:33:25 INFO - PROCESS | 2017 | Values: 163.0 165.0 162.0 165.0 163.0 165.0 165.0 164.0 164.0 163.0 11:33:25 INFO - PROCESS | 2017 | 11:33:25 INFO - PROCESS | 2017 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.50 stddev:3.49 (5.2%) stddev-sans-first:3.69 11:33:25 INFO - PROCESS | 2017 | Values: 67.0 68.0 69.0 67.0 66.0 65.0 66.0 65.0 68.0 77.0 11:33:25 INFO - PROCESS | 2017 | -------- Summary: end -------- 11:33:25 INFO - PROCESS | 2017 | 11:33:26 INFO - TEST-INFO | 2017: exit 0 11:33:26 INFO - TEST-OK | kraken | took 59192ms 11:33:26 INFO - SUITE-END | took 1176s 11:33:26 INFO - Completed test suite (00:19:37) 11:33:26 INFO - javascript benchmark 11:33:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3328.5839270091237, 3335.4996750487426, 3341.4653655415136, 3367.545381373514, 3405.046586955652, 4651.883702907429, 5693.544516438686, 5751.194832723417, 5764.221830052952, 5780.595358324914, 5105.336306280178, 5491.780328786854, 5726.083826587746, 5790.942090579093, 5803.738831752571, 5173.974130129353, 5204.687718736869, 5224.164133738584, 5238.60710446718, 5287.603429742765, 4410.2943529035365, 5294.258803767476, 5301.20481927712, 5303.814366497173, 5312.335958005249, 5184.922226166611, 5190.351206099238, 5194.428612852602, 5210.609204309692, 5251.343582052244, 5254.290670759437, 5277.182036784305, 5301.204819277101, 5305.283786688786, 5348.277982472356, 5115.641905066647, 5137.537621614073, 5145.922811157836, 5206.583473322125, 5207.791688332462, 5619.803306884281, 5633.32400111985, 5701.144828275792, 5701.743421546041, 5703.885922281531, 6178.413050760216, 6200.534959877982, 6209.192804935375, 6220.657863817488, 6244.219472565929, 6108.6759897029115, 6170.722317495679, 6202.658853763041, 6246.344133865924, 6246.562740608159, 5950.464458198783, 5954.821355359346, 5985.5810093293485, 5991.850203744942, 6014.338422773491, 5557.055300598908, 6292.874142517216, 6307.5269354798575, 6314.778982735582, 6320.209973753281, 6077.8480537986015, 6092.867496376233, 6111.297200821873, 6134.294556126013, 6153.384661533811, 5245.947540524546, 6221.5333849961435, 6253.46845518127, 6258.15514905491, 6274.247090349188, 6117.235345581802, 6165.167702360213, 6171.59884607499, 6197.1324014637985, 6215.409536094064, 6096.496448835484, 6163.260408750979, 6184.288806787187, 6188.412100850412, 6201.224846894138, 4947.950520494821, 4972.154733695281, 4976.576990955737, 4982.377202849644, 5026.195808670668, 4457.576530229623, 4458.866234012985, 4479.260921947907, 4490.079533695584, 4494.280915053576, 5578.972105139448, 5642.605017648725, 5642.85892852682, 5675.5459563234845, 5681.801136960186, 5166.870828229325, 6160.845978850475, 6250.093736408196, 6255.43701066897, 6270.2789179244055, 5705.5435565154685, 5705.885882282331, 5711.7144142792695, 5715.999700052557, 5746.0, 5392.137258038773, 5448.536874365644, 5454.400015998316, 5454.672719636835, 5466.562674985991, 6159.19930409044, 6176.135341052346, 6222.0, 6244.1570387997035, 6256.968715156304, 6241.906371404341, 6273.215848018997, 6286.245650521967, 6289.496840252677, 6293.653849038347, 6177.413145751147, 6248.187735594343, 6284.874302513833, 6287.622742635456, 6291.087792270004, 5252.894942101213, 6110.16388879229, 6114.084479019511, 6137.1101190328045, 6146.969265153645, 6219.378062193744, 6259.843503912257, 6262.279837818709, 6276.811695649138, 6309.179806625109, 6146.754129834757, 6147.692615369124, 6157.630542167484, 6161.353057928853, 6164.6917654118015, 5160.716160611202, 5731.3408957968695, 6008.759649613967, 6134.038624681799, 6145.508359331154, 6060.726512076225, 6070.219229985294, 6087.659905928906, 6087.817365479043, 6109.816705498843, 6156.353582873913, 6167.814965551041, 6168.25980882297, 6197.411245931629, 6217.689115544295, 5053.0, 5904.468597826216, 5957.940420595912, 5960.314563825043, 6036.396360364104], "value": 5672.494224599252, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [484.96218093280373, 499.6302735975377, 510.9463506331837, 522.932018837551, 545.9344878614567, 31030.53454198186, 40279.0, 41402.79298603503, 41478.37782433266, 41538.79230603843, 42809.35785963213, 43245.78377108118, 43252.78373608128, 43255.78372108143, 43288.78355608218, 9647.56585953632, 9754.365966212208, 9829.55766990487, 9833.065858743408, 9843.803123937518, 9607.231421486264, 9669.70990870275, 9715.562799674031, 9723.02769723029, 9730.221582273402, 9707.369021013646, 9764.951175244114, 9774.364666296704, 9789.0, 9792.412455252672, 9705.078017588317, 9766.462844543546, 9773.902260977371, 9775.31572789905, 9786.706398808012, 9712.465814380206, 9749.415035097845, 9761.951190244074, 9764.609415623367, 9803.754906127333, 40800.38799418011, 41175.7941210295, 41268.58731412707, 41322.0, 41549.584504154875, 3185.665505121975, 3267.950980735291, 3404.3021180657906, 3457.0493114393494, 3501.3347463981763, 25821.612675809876, 31782.0, 32800.67199328, 32868.50697239544, 32887.506687399706, 2853.9001134960386, 3148.3703259347994, 3179.3641271745514, 3210.646828848825, 3378.679025492574, 388802.0, 388987.0, 389436.05281973694, 389478.0, 390984.0, 33456.99629011133, 56898.14652780211, 57129.42870571324, 57268.427315727145, 57382.139267911014, 34006.82996585001, 35547.0, 35608.0, 35623.82188089095, 35644.821775891476, 14310.785338219936, 14454.638634034232, 14474.986750927334, 14483.493077742229, 14486.275686215648, 12183.634490965285, 12265.08011899111, 12291.877081229073, 12308.630741077783, 12352.814707779391, 5892.499137573354, 6638.800835974928, 7631.771046868603, 7854.2145785421, 7862.01724784402, 3260.136063943057, 3302.8348582570775, 3305.454599991023, 3307.503874418808, 3332.7333813294877, 980.3970558106713, 981.2983716642635, 981.8772653418323, 1021.4790456867051, 1024.7284469615558, 25336.0, 30359.241018974702, 30912.381752364825, 30915.0, 31151.376972460876, 1027.1679939249232, 1033.7415646088477, 1037.725002874239, 1048.8007278617038, 1077.3805062089173, 14040.0, 14299.285035748379, 14812.81497480199, 15691.293891774898, 16146.75779863303, 696920.0, 703860.0, 704245.0, 706611.0, 708445.0, 58883.41116588865, 59384.10923836146, 59496.702516488, 59510.0, 59642.0, 1253.3858409379338, 1374.6013656039636, 1386.1960063163342, 1415.7380884536394, 1416.992915035439, 30912.845435772677, 31614.36771264516, 31816.68183318137, 32021.519677204393, 32502.862399815895, 49266.75366623144, 49987.0, 50003.74998125132, 50028.49971500384, 50045.496815222585, 538438.0, 541487.0, 543409.0, 543525.0, 543885.0, 22084.76608958283, 22097.895105244996, 26439.339016523973, 26758.331041724112, 27577.44845103127, 46835.48073296218, 47757.76121119372, 47904.76047619739, 48412.0, 48540.75729621329, 39039.0, 39647.40528892011, 39972.0, 40727.0, 41263.381049283686, 32310.35379292448, 33959.320813583094, 39145.60854391533, 39295.0, 40479.392809107296, 38190.427143592315, 38434.6156538431, 38870.6112938867, 38889.0, 39326.0, 28147.014854479996, 29487.5256237183, 32653.510197346583, 34031.65968340384, 34553.0, 22793.0, 24521.0, 25634.615480768178, 25709.35726606775, 25934.610980834925], "value": 18476.256174964787, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.34966186709244, 369.36838007008015, 369.77258985723773, 389.98440062397503, 397.72755662371276, 17478.475645730632, 19884.20463181473, 20474.283400081, 21024.474388140305, 21163.788362116375, 19797.208111675514, 20063.297784577542, 20364.287249946217, 20658.690119648218, 20677.689834652454, 5345.65253258537, 5937.64374137552, 6139.815805525819, 6174.938250617482, 6177.66022868742, 6007.429294217064, 6020.608660437079, 6083.0, 6083.117947897552, 6086.300075491331, 5807.332156801958, 5954.13665018572, 5997.37027612101, 6069.302030266532, 6112.969435152818, 5753.252077229975, 5959.165716799652, 6007.429294217042, 6009.4591486766185, 6015.75936962521, 5164.2253661950635, 5217.739113044333, 5218.0, 5218.8695282617855, 5230.712310822903, 25529.61705574418, 25567.23298301054, 25581.23256302314, 25622.615660765103, 25886.0, 2187.9124835006583, 2220.289507357646, 2491.8504889706496, 2524.691083542066, 2863.18399256211, 13618.863811361858, 14758.70482590353, 15328.463503777315, 15597.68804623901, 16057.306819431597, 1766.5583604098974, 1814.129217975366, 1838.8528917686554, 1845.5847434327304, 1894.0719047666682, 119592.0, 123924.0, 124734.0, 126531.0, 127349.0, 8480.837386466412, 10375.584976601003, 10930.398828064534, 10931.398773067558, 11074.0, 13750.0, 13780.448782048807, 13784.379702913393, 13794.517191898236, 13813.861861381458, 7398.260173982666, 7604.505707129019, 7637.541747495168, 7723.884141737878, 7730.149683534807, 7259.963700181571, 7319.011933389031, 7414.740484083139, 7443.255674432622, 7452.143003554552, 5587.944120558743, 6459.450946669492, 6568.277489476154, 6600.339966003361, 6607.108040414579, 1664.4756901575965, 1726.5338358643096, 1749.2303386509896, 1776.2539733311783, 1777.5289548269718, 818.9140140285303, 893.6425429828121, 917.8118485710413, 1014.2089170447063, 1020.9183265338755, 17296.740548891776, 21894.562108758055, 21922.342329729814, 21983.450413739465, 22112.668309975365, 933.5565606336936, 951.9809603807885, 959.6161535385762, 977.6089564174245, 981.254246772458, 9502.857457138149, 10778.73053173677, 11699.06407487399, 11714.062874969983, 11717.414129293502, 565148.0, 571895.0, 583783.1621683814, 591485.0, 592784.0, 100007.0, 120295.79704202845, 121777.0, 123287.0, 123953.0, 968.5738275158908, 995.9800803984025, 1009.7021378693156, 1014.4876837197169, 1014.8477728340661, 17239.22423490921, 18364.449066528025, 18410.63178736391, 18804.87170769758, 19254.0, 52797.94404111819, 54401.72799135979, 54626.0, 55263.723681381336, 56110.59723506945, 71387.64306178436, 74702.62648686722, 76281.23718762964, 78066.82899756622, 79152.0, 6754.966225168842, 7821.960890195513, 7887.092984306878, 8104.149064348394, 8114.391420643357, 10682.305650132717, 12701.87298127007, 13020.28388438645, 13137.540186093442, 13172.946164307024, 10952.397618131079, 11237.47156889726, 11329.0, 11418.0, 11453.484593193492, 10742.19433542503, 11104.222704410613, 11265.436728163722, 11488.770224595628, 11519.308841469203, 11129.276597021491, 11289.0, 11673.883261167279, 11715.941420292844, 11730.296182229093, 7062.788116356517, 7262.286775882402, 7392.630368481447, 7600.619969001417, 7893.84212315739, 9522.666706665234, 10993.945030274797, 11405.0, 11529.711757206136, 11531.654050378502], "value": 9623.20772482295, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1537.0777533479913, 1575.3777257983097, 1784.955376115597, 1908.7423197868302, 1930.7683078030639, 8357.540335281557, 8869.86695199571, 8870.733877983655, 8872.290216782667, 8903.821923561525, 7754.767356979286, 7991.001124859393, 8381.748547543568, 8599.742007739778, 8687.478751274912, 2321.7330007049154, 2352.4118970257437, 2355.670206171129, 2359.7876191142796, 2360.008796305547, 2317.06159005603, 2340.9297721068397, 2367.0, 2368.2539999900064, 2370.6562548430466, 2339.415146213447, 2346.8474549154253, 2360.232924299601, 2363.8108951283857, 2365.124903785602, 2143.9785602143934, 2154.9461263468384, 2155.7089792878073, 2156.924507642233, 2156.9352919412445, 2308.3421224950976, 2318.7681231876845, 2319.5940710375617, 2320.454693147126, 2322.396176993977, 8712.433691810076, 8760.912390876074, 8820.779480513038, 8832.514211718353, 8834.779130521723, 5127.666701664417, 5280.20796880471, 5285.841424757264, 5299.019681358923, 5300.734963251822, 2916.300087978891, 3014.4724673182104, 3406.8466918988706, 3605.513255710498, 3625.274945010982, 1006.713086770267, 1012.8025035118155, 1025.7435641089728, 1026.3585259212991, 1033.6588925654592, 11450.484728187252, 11463.484143213574, 11615.245009074468, 11633.883661163365, 11753.000994915443, 3783.432485127253, 4632.25883858581, 4738.336632871401, 4740.928886066712, 4746.501617330131, 9891.159251463563, 9893.505324733878, 9894.0, 9901.504924753734, 9912.752181195383, 5293.814716484982, 5295.311609490742, 5299.814506492255, 5304.257403963448, 5319.86700332487, 4256.616904478612, 4361.738295702268, 4481.327800829901, 4495.011097558532, 4851.078295123915, 3906.8437262509183, 4002.5597184309704, 4027.2750904836826, 4027.9798601006805, 4031.5766844481495, 1260.6974326161655, 1293.2563775828935, 1297.1374036265777, 1306.8562458129597, 1308.9476420943247, 796.6693822063894, 904.9457032578066, 913.8492148795374, 942.6088173408097, 978.5351957819978, 4898.485659005824, 5731.77072917087, 5992.64044157352, 5995.52035837132, 6099.993501072362, 438.56581983835775, 446.15899030328063, 449.1466214193059, 451.6432018705186, 453.7164272329794, 3943.7633741975574, 3948.3879998600264, 4023.979880100581, 4060.411240370189, 4088.693347998912, 10356.948215258875, 10616.840747388795, 10764.354138751543, 10781.892181078088, 10787.730306742395, 10713.892861071445, 10726.141908647445, 10741.033307002408, 10743.355398676105, 10771.246012779031, 7665.655045522964, 8125.268725814587, 8243.670253189804, 8244.917550824535, 8250.793730156794, 5897.882042359043, 6082.239720034996, 6092.238470191226, 6098.298695650057, 6111.052786818051, 9493.572789224363, 9761.07269809367, 9995.150412215044, 10019.499025048573, 10066.8489972649, 9222.538873056454, 9581.712548623553, 9878.851817222603, 9929.900700992897, 10216.387016779017, 7356.374708149867, 7599.810004749926, 7612.08654961386, 7696.538207707556, 7705.383569314554, 8098.7165449209, 8356.874646880424, 8440.577971101544, 8574.356923230658, 8579.528125953133, 7517.248275172439, 7523.360514356341, 7528.171901090766, 7638.885416718643, 7692.461527693008, 7417.554946703215, 7440.181580026085, 7466.290702383265, 7496.137944136276, 7514.323710866049, 6955.130608673916, 7007.439404847702, 7094.042304289062, 7095.361417472453, 7103.644817759195, 4937.407511098691, 4974.278729584263, 5035.597152227886, 5038.823641172541, 5102.872428189325, 4958.801647934042, 4984.102861484823, 5076.771545280545, 5140.074786538459, 5214.504622060898], "value": 4477.130457484613, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.2999416397726, 300.90671891713566, 314.7497739297259, 316.4920302913822, 320.78026551811996, 4375.737455752649, 5497.8075767348155, 5512.614117011805, 5541.974734674088, 5690.914636280449, 4486.730796152225, 4874.8537543873745, 5428.972855135718, 5451.509364157225, 5480.287562616864, 4174.8121334539865, 4187.476565429321, 4197.16056788642, 4201.1807697499, 4212.578742125794, 3492.842822073013, 3604.981975090121, 4179.017930786263, 4202.138561594881, 4207.978960105195, 3593.389123848952, 3932.4494570760116, 3952.3281042222748, 4135.586441355856, 4167.916641667165, 3584.7849129052343, 4128.401381799622, 4129.855455059073, 4138.1103062841485, 4141.91716165675, 2669.878650966599, 3586.0317714217276, 3586.3903136466865, 3589.587197472298, 3622.510961020255, 4457.821687132511, 5215.1134307167495, 5281.339832520935, 5315.920261196085, 5367.221752845816, 4407.691461597689, 4416.293393057095, 4484.663650226214, 4524.524924882873, 4754.572088512051, 4938.851834444972, 5711.828645140652, 5734.283214598176, 5752.597318187729, 5761.279840019997, 3522.0, 3836.040989752562, 3969.3053715599945, 3973.6356867663694, 3994.3609022556543, 4548.839301331874, 5614.9505430517565, 5868.735906884243, 5989.484416545061, 6196.1944947157035, 3619.2942376236906, 3779.848806047727, 3850.4994350734787, 3977.980110099431, 4018.417329487208, 4078.817143028548, 4083.734557253769, 4094.0992981544014, 4102.958970410317, 4110.547839737626, 4435.667324950641, 4575.565321294472, 4606.61413860812, 4623.69945953512, 4762.214234651313, 5423.7830486780085, 5620.718964051781, 5650.519705825051, 5657.8019769307875, 5685.545156387479, 1361.2921280934056, 1378.6277705019588, 1381.8065470834092, 1387.2439520461373, 1396.2809153285862, 780.4146889832625, 801.3348920396057, 860.9009963854237, 907.2016625369632, 924.9306302027375, 4467.620252278528, 4915.410150781858, 5166.018456493254, 5317.361916570037, 5339.359276886798, 5524.83978364548, 5574.912891986024, 5859.392570306173, 5863.618864773776, 5908.881822363529, 3930.665893399036, 5076.6953982760415, 5126.92309615356, 5265.131253343232, 5455.1544510600925, 2663.5072511585417, 2723.9591406128925, 3120.1731541141617, 3128.4212420702243, 3141.434541782455, 5903.940960590339, 6146.569740118238, 6195.938040619626, 6206.441420272197, 6210.347913469021, 6013.939860601426, 6015.578909476295, 6050.969745151246, 6062.939370606237, 6083.756649733961, 5660.603757736919, 5875.441833025856, 6101.60339577926, 6122.806052819657, 6123.724432400552, 4968.900621987612, 5445.542080778655, 5527.402121003122, 5725.828225153252, 5945.959457095078, 5171.543516829476, 5333.599980001438, 5572.804951826666, 5820.796272130455, 5824.213731146241, 5019.7239151847, 5194.298769666047, 5422.927503129373, 5901.911471327848, 6097.847553811191, 3337.4326364517606, 3907.9413808792324, 4039.676825853866, 4048.5344185417875, 4075.2053349596545, 5512.007838589093, 5818.301803783404, 5847.356790753099, 5868.471837534642, 5875.6203737486385, 4828.8893554481965, 4920.975395123001, 5417.582417582417, 5423.457654234545, 5704.914426283692, 5365.275687782256, 5709.429057094258, 5751.971240143773, 5806.303243610793, 5816.82549523515, 4260.233158031584, 4798.688085274446, 4885.287181741973, 5680.926461841481, 5706.400827913009, 5446.813614035834, 5479.6026463592825, 5716.342620598684, 5782.508486778671, 5783.797567085132, 4982.128127577732, 5631.859203519781, 5643.548516118783, 5651.2935883014625, 5668.744906479301], "value": 4147.592511305701, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.7424040225316, 716.6810769207701, 764.4381379685933, 818.0142034300934, 834.3408707121376, 15999.200039997997, 16338.34646614137, 16347.83652163478, 16347.918260408711, 16360.918195409022, 14717.632059198526, 14797.038192517479, 14811.0, 14863.331150098244, 14878.925605371986, 694.9965250173742, 714.5319815520817, 720.020771750419, 721.174255477478, 864.1056506515741, 718.5042320798658, 718.5329535801744, 863.654538184728, 893.5889490834224, 898.716904175186, 927.3276874266137, 939.0468674295596, 939.3659279986016, 943.7640589852537, 945.8959514453404, 944.4569372610777, 944.7354740672623, 944.7590864329586, 944.8441007233798, 946.129560804062, 542.2652306125223, 702.9964850175717, 703.0263085626393, 703.2931903437064, 705.7353492440335, 13181.86818131816, 14322.14067155974, 14327.283635818272, 14433.35049922756, 14438.422463101464, 14109.576712698636, 14573.125612463286, 14575.125492470379, 14685.412583496647, 14856.851431485655, 10511.421871797049, 11272.605458808985, 11650.533978640844, 11786.0, 12400.255984640951, 3319.3029463812627, 3890.455336252927, 3902.3756199008308, 4055.634992850628, 4081.2449696806184, 99027.0, 111522.44238778835, 113886.29170562365, 116950.41524792321, 117711.0, 11355.034822040054, 11426.25729327591, 11493.42532873353, 11513.712157196138, 11520.884791152148, 23982.7601723984, 24391.02435902544, 24432.267031989068, 24437.511249774903, 24481.510369792504, 7932.325752311002, 8077.111517733045, 8246.876296855431, 8355.456895301786, 8360.0, 4407.338899165151, 4417.204903117406, 4447.799849006802, 4609.792559334771, 4668.929966050512, 3671.7883098577404, 3736.2714270717493, 3777.0934975606206, 3783.281176576442, 3786.5456145262747, 489.5104895104895, 612.1399433795524, 615.5291202230297, 652.4714980865514, 679.6194131286495, 610.6702380714364, 648.8799572079181, 674.3492529708855, 678.6606696651675, 685.239384283445, 8330.142565178774, 9397.201237894718, 9528.0, 9642.903570964341, 9838.11456968862, 646.9061986012002, 662.4501663619185, 694.0560837261321, 699.1330749870125, 701.0, 4434.401355816924, 4605.309203619484, 4726.125666751662, 4739.312799644033, 4758.762061896891, 100675.0, 104931.4753426228, 118127.8187218134, 158645.51513121283, 172996.54006919792, 81293.0, 142178.62570994295, 144679.0, 146233.5376646241, 148656.0, 121519.3924030392, 122664.0, 122916.0, 123355.38322308511, 123953.0, 9107.316951228817, 9126.269898407978, 9223.44659320443, 9265.0, 9295.147144027353, 56181.71909140428, 58026.7098664504, 60916.086258707044, 63409.0, 67976.98034529386, 60698.0, 72974.63512682403, 78317.21682783327, 85862.14137858791, 87223.0, 13434.865651343362, 13453.663658408617, 13728.313584320944, 13820.792688109485, 14102.576922692335, 14195.929020354832, 14919.701605968037, 14982.438584584559, 15331.233438327816, 15595.220238988231, 14015.018948673494, 14024.22866742339, 14337.64155896111, 14600.707985840436, 14829.555113346616, 13804.309784510935, 14284.714305714035, 14330.355134018786, 14479.710405792035, 14832.703345933236, 13508.0, 13684.315784210949, 14076.929615351857, 14355.928220359248, 14413.964090054802, 11541.502762540747, 11595.652130436101, 11847.940760296487, 11861.940690296493, 11914.344711040976, 10921.0, 11328.716782080513, 11462.598809041643, 11846.763064738485, 11890.46492907804], "value": 7930.668075614509, "unit": "score"}], "name": "dromaeo_css", "value": 7277.398939372977, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 113.0, 112.0, 114.0, 114.0, 114.0, 114.0, 113.0, 112.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 135.0, 136.0, 167.0, 124.0, 132.0, 116.0, 129.0, 196.0, 135.0], "value": 141.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 184.0, 184.0, 185.0, 181.0, 182.0, 182.0, 185.0, 184.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 57.0, 61.0, 88.0, 57.0, 57.0, 65.0, 68.0, 82.0, 57.0], "value": 67.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 69.0, 100.0, 93.0, 114.0, 97.0, 98.0, 70.0, 68.0, 128.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 136.0, 120.0, 88.0, 84.0, 88.0, 85.0, 88.0, 86.0], "value": 95.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 94.0, 94.0, 92.0, 93.0, 94.0, 93.0, 94.0], "value": 93.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 84.0, 86.0, 85.0, 87.0, 84.0, 97.0, 123.0, 84.0], "value": 90.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 56.0, 56.0, 54.0, 51.0, 53.0, 53.0, 54.0, 53.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 78.0, 79.0, 75.0, 73.0, 70.0, 71.0, 73.0, 71.0, 74.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 83.0, 82.0, 83.0, 85.0, 85.0, 82.0, 88.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 143.0, 166.0, 150.0, 136.0, 125.0, 146.0, 133.0, 126.0, 158.0], "value": 142.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 162.0, 165.0, 163.0, 165.0, 165.0, 164.0, 164.0, 163.0], "value": 163.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 69.0, 67.0, 66.0, 65.0, 66.0, 65.0, 68.0, 77.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1459.1999999999998, "alertThreshold": 2.0}]} 11:33:26 INFO - Return code: 0 11:33:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:33:26 INFO - # TBPL SUCCESS # 11:33:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:33:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:33:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:33:26 INFO - 2016-08-07 11:33:26.979 screenresolution[2021:15943] starting screenresolution argv=screenresolution get 11:33:26 INFO - 2016-08-07 11:33:26.982 screenresolution[2021:15943] Display 0: 1600x1200x32@60 11:33:26 INFO - 2016-08-07 11:33:26.988 screenresolution[2022:15946] starting screenresolution argv=screenresolution list 11:33:26 INFO - Available Modes on Display 0 11:33:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:33:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:33:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:33:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:33:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:33:27 INFO - Intel Iris: 11:33:27 INFO - Chipset Model: Intel Iris 11:33:27 INFO - Type: GPU 11:33:27 INFO - Bus: Built-In 11:33:27 INFO - VRAM (Dynamic, Max): 1536 MB 11:33:27 INFO - Vendor: Intel (0x8086) 11:33:27 INFO - Device ID: 0x0a2e 11:33:27 INFO - Revision ID: 0x0009 11:33:27 INFO - Displays: 11:33:27 INFO - Display: 11:33:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:33:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:33:27 INFO - Display Serial Number: 1600x1200 60 11:33:27 INFO - Main Display: Yes 11:33:27 INFO - Mirror: Off 11:33:27 INFO - Online: Yes 11:33:27 INFO - Rotation: Supported 11:33:27 INFO - Return code: 0 11:33:27 INFO - Running post-action listener: _resource_record_post_action 11:33:27 INFO - [mozharness: 2016-08-07 18:33:27.229323Z] Finished run-tests step (success) 11:33:27 INFO - Running post-run listener: _resource_record_post_run 11:33:27 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 229376; Write bytes: 704984064; Read time: 4; Write time: 1855 11:33:27 INFO - TinderboxPrint: CPU usage
53.6% 11:33:27 INFO - TinderboxPrint: I/O read bytes / time
229,376 / 4 11:33:27 INFO - TinderboxPrint: I/O write bytes / time
704,984,064 / 1,855 11:33:27 INFO - TinderboxPrint: CPU idle
2,251.4 (46.4%) 11:33:27 INFO - TinderboxPrint: CPU system
975.7 (20.1%) 11:33:27 INFO - TinderboxPrint: CPU user
1,622.6 (33.5%) 11:33:27 INFO - TinderboxPrint: Swap in / out
406,417,408 / 0 11:33:27 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 394004992; Write bytes: 389596672; Read time: 29377; Write time: 716 11:33:27 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 196608; Write bytes: 293428736; Read time: 3; Write time: 1092 11:33:27 INFO - Running post-run listener: _upload_blobber_files 11:33:27 INFO - Blob upload gear active. 11:33:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:33:27 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:33:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:33:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:33:28 INFO - (blobuploader) - INFO - Open directory for files ... 11:33:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:33:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:33:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:28 INFO - (blobuploader) - INFO - Done attempting. 11:33:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:33:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:33:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:29 INFO - (blobuploader) - INFO - Done attempting. 11:33:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:33:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:33:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:32 INFO - (blobuploader) - INFO - Done attempting. 11:33:32 INFO - (blobuploader) - INFO - Iteration through files over. 11:33:32 INFO - Return code: 0 11:33:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:33:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:33:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6ae53b346f9ce90338113b4beb4ebafef0fdd959e3b5f6cdbfef25f587f10ee2b8101ed0e30dc5e631250148119731d6bbeac67f837967a91cac10e1d7f64ba3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e324a4881268cc328af88c62078855eed83250b04d46a7e234e5fd5e856eb55a0034b238ddba8e9d83f61aca1ba7db924fa974c03a1ab0097074a459bc0621b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f338c98f7cc85cf344e1049330d21b5637ed22679c52ad8dd4f6189895b459038169903d57f246021ae09f4547ec6a2f0f737db829e008fce9f17b710fed7f3d"} 11:33:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:33:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:33:32 INFO - Contents: 11:33:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6ae53b346f9ce90338113b4beb4ebafef0fdd959e3b5f6cdbfef25f587f10ee2b8101ed0e30dc5e631250148119731d6bbeac67f837967a91cac10e1d7f64ba3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e324a4881268cc328af88c62078855eed83250b04d46a7e234e5fd5e856eb55a0034b238ddba8e9d83f61aca1ba7db924fa974c03a1ab0097074a459bc0621b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f338c98f7cc85cf344e1049330d21b5637ed22679c52ad8dd4f6189895b459038169903d57f246021ae09f4547ec6a2f0f737db829e008fce9f17b710fed7f3d"} 11:33:32 INFO - Running post-run listener: copy_logs_to_upload_dir 11:33:32 INFO - Copying logs to upload dir... 11:33:32 INFO - mkdir: /builds/slave/test/build/upload/logs 11:33:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.693414 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-08-07 11:33:32.134323) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 11:33:32.138064) ========= 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.kU2JQuM4N5/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.YVE5w49fjw/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6ae53b346f9ce90338113b4beb4ebafef0fdd959e3b5f6cdbfef25f587f10ee2b8101ed0e30dc5e631250148119731d6bbeac67f837967a91cac10e1d7f64ba3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e324a4881268cc328af88c62078855eed83250b04d46a7e234e5fd5e856eb55a0034b238ddba8e9d83f61aca1ba7db924fa974c03a1ab0097074a459bc0621b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f338c98f7cc85cf344e1049330d21b5637ed22679c52ad8dd4f6189895b459038169903d57f246021ae09f4547ec6a2f0f737db829e008fce9f17b710fed7f3d"} build_url:https://queue.taskcluster.net/v1/task/RzTCVvAjRRuN0vc9nXrgPw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/RzTCVvAjRRuN0vc9nXrgPw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6ae53b346f9ce90338113b4beb4ebafef0fdd959e3b5f6cdbfef25f587f10ee2b8101ed0e30dc5e631250148119731d6bbeac67f837967a91cac10e1d7f64ba3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e324a4881268cc328af88c62078855eed83250b04d46a7e234e5fd5e856eb55a0034b238ddba8e9d83f61aca1ba7db924fa974c03a1ab0097074a459bc0621b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f338c98f7cc85cf344e1049330d21b5637ed22679c52ad8dd4f6189895b459038169903d57f246021ae09f4547ec6a2f0f737db829e008fce9f17b710fed7f3d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 11:33:32.171339) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 11:33:32.171675) ========= 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.kU2JQuM4N5/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.YVE5w49fjw/Listeners TMPDIR=/var/folders/hx/wyz88y_j2rv2m160wr6142w000000w/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.005338 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 11:33:32.222811) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 11:33:32.223463) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 11:33:32.224145) ========= ========= Total master_lag: 0.18 =========