builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0259 starttime: 1470660673.9 results: success (0) buildid: 20160808030450 builduid: 8e3f7f823f2346f09b7b2d4d3471c35a revision: 1a72f2737bce150bd90c831341cc7b5a93fc2aa9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 05:51:13.896476) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 05:51:13.896891) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 05:51:13.897159) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 05:51:13.922009) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:51:13.922299) ========= 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.uOjtYYgBh1/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.MvdrBawwiL/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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-08 05:51:13-- 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% 156M=0s 2016-08-08 05:51:14 (156 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084337 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:51:14.028259) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:51:14.028574) ========= 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.uOjtYYgBh1/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.MvdrBawwiL/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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.021033 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:51:14.076905) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 05:51:14.077213) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1a72f2737bce150bd90c831341cc7b5a93fc2aa9 --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 1a72f2737bce150bd90c831341cc7b5a93fc2aa9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uOjtYYgBh1/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.MvdrBawwiL/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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-08 05:51:14,158 truncating revision to first 12 chars 2016-08-08 05:51:14,158 Setting DEBUG logging. 2016-08-08 05:51:14,158 attempt 1/10 2016-08-08 05:51:14,158 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1a72f2737bce?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 05:51:15,315 unpacking tar archive at: fx-team-1a72f2737bce/testing/mozharness/ program finished with exit code 0 elapsedTime=1.435528 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 05:51:15.536910) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 05:51:15.537450) ========= script_repo_revision: 1a72f2737bce150bd90c831341cc7b5a93fc2aa9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 05:51:15.538076) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 05:51:15.538544) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 05:51:15.557751) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-08-08 05:51:15.558116) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uOjtYYgBh1/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.MvdrBawwiL/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 05:51:15 INFO - MultiFileLogger online at 20160808 05:51:15 in /builds/slave/test 05:51:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:51:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:51:15 INFO - {'append_to_log': False, 05:51:15 INFO - 'base_work_dir': '/builds/slave/test', 05:51:15 INFO - 'blob_upload_branch': 'Fx-Team', 05:51:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:51:15 INFO - 'branch': 'Fx-Team', 05:51:15 INFO - 'buildbot_json_path': 'buildprops.json', 05:51:15 INFO - 'config_files': ('talos/mac_config.py',), 05:51:15 INFO - 'default_actions': ('clobber', 05:51:15 INFO - 'read-buildbot-config', 05:51:15 INFO - 'download-and-extract', 05:51:15 INFO - 'populate-webroot', 05:51:15 INFO - 'create-virtualenv', 05:51:15 INFO - 'install', 05:51:15 INFO - 'run-tests'), 05:51:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:51:15 INFO - 'download_minidump_stackwalk': True, 05:51:15 INFO - 'download_symbols': 'ondemand', 05:51:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:51:15 INFO - 'tooltool.py': '/tools/tooltool.py', 05:51:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:51:15 INFO - '/tools/misc-python/virtualenv.py')}, 05:51:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:51:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:51:15 INFO - 'installer_path': 'installer.exe', 05:51:15 INFO - 'log_level': 'info', 05:51:15 INFO - 'log_name': 'talos', 05:51:15 INFO - 'log_to_console': True, 05:51:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:51:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:51:15 INFO - 'opt_config_files': (), 05:51:15 INFO - 'pip_index': False, 05:51:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:51:15 INFO - 'cmd': ('bash', 05:51:15 INFO - '-c', 05:51:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:51:15 INFO - 'enabled': True, 05:51:15 INFO - 'halt_on_failure': False, 05:51:15 INFO - 'name': 'check_screen_resolution'},), 05:51:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:51:15 INFO - 'cmd': ('bash', 05:51:15 INFO - '-c', 05:51:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:51:15 INFO - 'enabled': True, 05:51:15 INFO - 'halt_on_failure': False, 05:51:15 INFO - 'name': 'check_screen_resolution'},), 05:51:15 INFO - 'run_cmd_checks_enabled': True, 05:51:15 INFO - 'sps_profile': False, 05:51:15 INFO - 'sps_profile_interval': 0, 05:51:15 INFO - 'suite': 'dromaeojs-e10s', 05:51:15 INFO - 'system_bits': '32', 05:51:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:51:15 INFO - 'title': 't-yosemite-r7-0259', 05:51:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:51:15 INFO - 'use_talos_json': True, 05:51:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:51:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:51:15 INFO - 'work_dir': 'build'} 05:51:15 INFO - [mozharness: 2016-08-08 12:51:15.762316Z] Running clobber step. 05:51:15 INFO - Running pre-action listener: _resource_record_pre_action 05:51:15 INFO - Running main action method: clobber 05:51:15 INFO - rmtree: /builds/slave/test/build 05:51:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:51:16 INFO - Running post-action listener: _resource_record_post_action 05:51:16 INFO - [mozharness: 2016-08-08 12:51:16.763371Z] Finished clobber step (success) 05:51:16 INFO - [mozharness: 2016-08-08 12:51:16.763637Z] Running read-buildbot-config step. 05:51:16 INFO - Running pre-action listener: _resource_record_pre_action 05:51:16 INFO - Running main action method: read_buildbot_config 05:51:16 INFO - Using buildbot properties: 05:51:16 INFO - { 05:51:16 INFO - "project": "", 05:51:16 INFO - "product": "firefox", 05:51:16 INFO - "script_repo_revision": "production", 05:51:16 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 05:51:16 INFO - "repository": "", 05:51:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 05:51:16 INFO - "buildid": "20160808030450", 05:51:16 INFO - "pgo_build": "False", 05:51:16 INFO - "basedir": "/builds/slave/test", 05:51:16 INFO - "buildnumber": 82, 05:51:16 INFO - "slavename": "t-yosemite-r7-0259", 05:51:16 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:51:16 INFO - "platform": "yosemite_r7", 05:51:16 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 05:51:16 INFO - "branch": "fx-team", 05:51:16 INFO - "repo_path": "integration/fx-team", 05:51:16 INFO - "revision": "1a72f2737bce150bd90c831341cc7b5a93fc2aa9", 05:51:16 INFO - "stage_platform": "macosx64", 05:51:16 INFO - "builduid": "8e3f7f823f2346f09b7b2d4d3471c35a", 05:51:16 INFO - "slavebuilddir": "test" 05:51:16 INFO - } 05:51:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/MrLTufnlSjSGjQZ3NLyTHg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 05:51:16 INFO - Running post-action listener: _resource_record_post_action 05:51:16 INFO - [mozharness: 2016-08-08 12:51:16.768752Z] Finished read-buildbot-config step (success) 05:51:16 INFO - [mozharness: 2016-08-08 12:51:16.768929Z] Running download-and-extract step. 05:51:16 INFO - Running pre-action listener: _resource_record_pre_action 05:51:16 INFO - Running main action method: download_and_extract 05:51:16 INFO - mkdir: /builds/slave/test/build/tests 05:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:16 INFO - trying https://queue.taskcluster.net/v1/task/MrLTufnlSjSGjQZ3NLyTHg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 05:51:16 INFO - Downloading https://queue.taskcluster.net/v1/task/MrLTufnlSjSGjQZ3NLyTHg/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 05:51:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MrLTufnlSjSGjQZ3NLyTHg/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 05:51:18 INFO - Downloaded 1199 bytes. 05:51:18 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:51:18 INFO - Using the following test package requirements: 05:51:18 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:51:18 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:51:18 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 05:51:18 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:51:18 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 05:51:18 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:51:18 INFO - u'jsshell-mac.zip'], 05:51:18 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:51:18 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 05:51:18 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:51:18 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:51:18 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 05:51:18 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:51:18 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 05:51:18 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:51:18 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 05:51:18 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:51:18 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 05:51:18 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:18 INFO - trying https://queue.taskcluster.net/v1/task/MrLTufnlSjSGjQZ3NLyTHg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:51:18 INFO - Downloading https://queue.taskcluster.net/v1/task/MrLTufnlSjSGjQZ3NLyTHg/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 05:51:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MrLTufnlSjSGjQZ3NLyTHg/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 05:51:19 INFO - Downloaded 16324192 bytes. 05:51:19 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'] 05:51:19 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 05:51:22 INFO - Return code: 0 05:51:22 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 05:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:22 INFO - trying https://queue.taskcluster.net/v1/task/MrLTufnlSjSGjQZ3NLyTHg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:51:22 INFO - Downloading https://queue.taskcluster.net/v1/task/MrLTufnlSjSGjQZ3NLyTHg/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 05:51:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MrLTufnlSjSGjQZ3NLyTHg/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 05:51:23 INFO - Downloaded 16324192 bytes. 05:51:23 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'] 05:51:23 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 05:51:26 INFO - Return code: 0 05:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:26 INFO - trying https://queue.taskcluster.net/v1/task/MrLTufnlSjSGjQZ3NLyTHg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:51:26 INFO - Downloading https://queue.taskcluster.net/v1/task/MrLTufnlSjSGjQZ3NLyTHg/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 05:51:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MrLTufnlSjSGjQZ3NLyTHg/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 05:51:27 INFO - Downloaded 14413723 bytes. 05:51:27 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'] 05:51:27 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 05:51:27 INFO - Return code: 0 05:51:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:27 INFO - trying https://queue.taskcluster.net/v1/task/MrLTufnlSjSGjQZ3NLyTHg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:51:27 INFO - Downloading https://queue.taskcluster.net/v1/task/MrLTufnlSjSGjQZ3NLyTHg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 05:51:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MrLTufnlSjSGjQZ3NLyTHg/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 05:51:31 INFO - Downloaded 111877730 bytes. 05:51:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MrLTufnlSjSGjQZ3NLyTHg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:51:31 INFO - mkdir: /builds/slave/test/properties 05:51:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:51:31 INFO - Writing to file /builds/slave/test/properties/build_url 05:51:31 INFO - Contents: 05:51:31 INFO - build_url:https://queue.taskcluster.net/v1/task/MrLTufnlSjSGjQZ3NLyTHg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:51:32 INFO - Running post-action listener: _resource_record_post_action 05:51:32 INFO - Running post-action listener: set_extra_try_arguments 05:51:32 INFO - [mozharness: 2016-08-08 12:51:32.122961Z] Finished download-and-extract step (success) 05:51:32 INFO - [mozharness: 2016-08-08 12:51:32.123091Z] Running populate-webroot step. 05:51:32 INFO - Running pre-action listener: _resource_record_pre_action 05:51:32 INFO - Running main action method: populate_webroot 05:51:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:51:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:51:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:51:32 INFO - '--tppagecycles', 05:51:32 INFO - '7'], 05:51:32 INFO - 'tests': ['tsvgm']}}, 05:51:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:51:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:51:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:51:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:51:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:51:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:51:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:32 INFO - 'talos_options': ['--disable-e10s'], 05:51:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:51:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:51:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:32 INFO - 'talos_options': ['--disable-e10s'], 05:51:32 INFO - 'tests': ['damp', 'tps']}, 05:51:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:32 INFO - 'tests': ['damp', 'tps']}, 05:51:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:51:32 INFO - 'tests': ['dromaeo_dom']}, 05:51:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:51:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:51:32 INFO - 'tests': ['basic_compositor_video']}, 05:51:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:51:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:51:32 INFO - 'tests': ['a11yr', 05:51:32 INFO - 'ts_paint', 05:51:32 INFO - 'tpaint', 05:51:32 INFO - 'sessionrestore', 05:51:32 INFO - 'sessionrestore_no_auto_restore', 05:51:32 INFO - 'tabpaint']}, 05:51:32 INFO - 'other-e10s': {'tests': ['a11yr', 05:51:32 INFO - 'ts_paint', 05:51:32 INFO - 'tpaint', 05:51:32 INFO - 'sessionrestore', 05:51:32 INFO - 'sessionrestore_no_auto_restore', 05:51:32 INFO - 'tabpaint']}, 05:51:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:51:32 INFO - 'ts_paint', 05:51:32 INFO - 'tpaint', 05:51:32 INFO - 'sessionrestore', 05:51:32 INFO - 'sessionrestore_no_auto_restore', 05:51:32 INFO - 'tabpaint']}, 05:51:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:51:32 INFO - 'ts_paint', 05:51:32 INFO - 'tpaint', 05:51:32 INFO - 'sessionrestore', 05:51:32 INFO - 'sessionrestore_no_auto_restore', 05:51:32 INFO - 'tabpaint']}, 05:51:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:51:32 INFO - 'tests': ['a11yr', 05:51:32 INFO - 'ts_paint', 05:51:32 INFO - 'tpaint', 05:51:32 INFO - 'sessionrestore', 05:51:32 INFO - 'sessionrestore_no_auto_restore', 05:51:32 INFO - 'tabpaint']}, 05:51:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:51:32 INFO - 'tests': ['a11yr', 05:51:32 INFO - 'ts_paint', 05:51:32 INFO - 'tpaint', 05:51:32 INFO - 'sessionrestore', 05:51:32 INFO - 'sessionrestore_no_auto_restore', 05:51:32 INFO - 'tabpaint']}, 05:51:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:51:32 INFO - 'tests': ['tsvgx', 05:51:32 INFO - 'tsvgr_opacity', 05:51:32 INFO - 'tart', 05:51:32 INFO - 'tscrollx', 05:51:32 INFO - 'cart']}, 05:51:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:51:32 INFO - 'tsvgr_opacity', 05:51:32 INFO - 'tart', 05:51:32 INFO - 'tscrollx', 05:51:32 INFO - 'cart']}, 05:51:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:32 INFO - 'talos_options': ['--disable-e10s'], 05:51:32 INFO - 'tests': ['tp5o']}, 05:51:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:32 INFO - 'tests': ['tp5o']}, 05:51:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:32 INFO - 'talos_options': ['--disable-e10s', 05:51:32 INFO - '--xperf_path', 05:51:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:51:32 INFO - 'tests': ['tp5n']}, 05:51:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:32 INFO - 'talos_options': ['--xperf_path', 05:51:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:51:32 INFO - 'tests': ['tp5n']}}, 05:51:32 INFO - 'talos.zip': {'path': '', 05:51:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:51:32 INFO - Running post-action listener: _resource_record_post_action 05:51:32 INFO - [mozharness: 2016-08-08 12:51:32.142000Z] Finished populate-webroot step (success) 05:51:32 INFO - [mozharness: 2016-08-08 12:51:32.142142Z] Running create-virtualenv step. 05:51:32 INFO - Running pre-action listener: _resource_record_pre_action 05:51:32 INFO - Running main action method: create_virtualenv 05:51:32 INFO - Creating virtualenv /builds/slave/test/build/venv 05:51:32 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 05:51:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:51:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:51:32 INFO - Using real prefix '/tools/python27' 05:51:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:51:32 INFO - Installing distribute.............................................................................................................................................................................................done. 05:51:35 INFO - Installing pip.................done. 05:51:35 INFO - Return code: 0 05:51:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103ccca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d61618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa941593d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c30d30>, '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 0x103995db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c28b20>, '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.uOjtYYgBh1/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.MvdrBawwiL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 05:51:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:51:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:51:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uOjtYYgBh1/Render', 05:51:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:51:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:51:35 INFO - 'HOME': '/Users/cltbld', 05:51:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:51:35 INFO - 'LOGNAME': 'cltbld', 05:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:35 INFO - 'MOZ_NO_REMOTE': '1', 05:51:35 INFO - 'NO_EM_RESTART': '1', 05:51:35 INFO - 'PAGER': '/bin/cat', 05:51:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:35 INFO - 'PWD': '/builds/slave/test', 05:51:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:51:35 INFO - 'SHELL': '/bin/bash', 05:51:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MvdrBawwiL/Listeners', 05:51:35 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 05:51:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:51:35 INFO - 'USER': 'cltbld', 05:51:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:51:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:35 INFO - 'XPC_FLAGS': '0x0', 05:51:35 INFO - 'XPC_SERVICE_NAME': '0', 05:51:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:51:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:36 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 05:51:36 INFO - Cleaning up... 05:51:36 INFO - Return code: 0 05:51:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:51:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103ccca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d61618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa941593d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c30d30>, '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 0x103995db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c28b20>, '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.uOjtYYgBh1/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.MvdrBawwiL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 05:51:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:51:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:51:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uOjtYYgBh1/Render', 05:51:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:51:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:51:36 INFO - 'HOME': '/Users/cltbld', 05:51:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:51:36 INFO - 'LOGNAME': 'cltbld', 05:51:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:36 INFO - 'MOZ_NO_REMOTE': '1', 05:51:36 INFO - 'NO_EM_RESTART': '1', 05:51:36 INFO - 'PAGER': '/bin/cat', 05:51:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:51:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:36 INFO - 'PWD': '/builds/slave/test', 05:51:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:51:36 INFO - 'SHELL': '/bin/bash', 05:51:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MvdrBawwiL/Listeners', 05:51:36 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 05:51:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:51:36 INFO - 'USER': 'cltbld', 05:51:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:51:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:51:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:36 INFO - 'XPC_FLAGS': '0x0', 05:51:36 INFO - 'XPC_SERVICE_NAME': '0', 05:51:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:51:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:36 INFO - Downloading/unpacking psutil>=3.1.1 05:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:51:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:51:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:51:39 INFO - Installing collected packages: psutil 05:51:39 INFO - Running setup.py install for psutil 05:51:39 INFO - building 'psutil._psutil_osx' extension 05:51:39 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 05:51:39 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 05:51:39 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 05:51:39 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 05:51:39 INFO - building 'psutil._psutil_posix' extension 05:51:39 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 05:51:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:51:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:51:40 INFO - ^ 05:51:40 INFO - 1 warning generated. 05:51:40 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 05:51:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:51:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:51:40 INFO - Successfully installed psutil 05:51:40 INFO - Cleaning up... 05:51:40 INFO - Return code: 0 05:51:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:51: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')]} 05:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51: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')]} 05:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:40 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 0x103ccca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d61618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa941593d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c30d30>, '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 0x103995db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c28b20>, '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.uOjtYYgBh1/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.MvdrBawwiL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 05:51:40 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 05:51:40 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 05:51:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uOjtYYgBh1/Render', 05:51:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:51:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:51:40 INFO - 'HOME': '/Users/cltbld', 05:51:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:51:40 INFO - 'LOGNAME': 'cltbld', 05:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:40 INFO - 'MOZ_NO_REMOTE': '1', 05:51:40 INFO - 'NO_EM_RESTART': '1', 05:51:40 INFO - 'PAGER': '/bin/cat', 05:51:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:40 INFO - 'PWD': '/builds/slave/test', 05:51:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:51:40 INFO - 'SHELL': '/bin/bash', 05:51:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MvdrBawwiL/Listeners', 05:51:40 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 05:51:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:51:40 INFO - 'USER': 'cltbld', 05:51:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:51:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:40 INFO - 'XPC_FLAGS': '0x0', 05:51:40 INFO - 'XPC_SERVICE_NAME': '0', 05:51:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:51:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:51:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:51:43 INFO - Installing collected packages: mozsystemmonitor 05:51:43 INFO - Running setup.py install for mozsystemmonitor 05:51:43 INFO - Successfully installed mozsystemmonitor 05:51:43 INFO - Cleaning up... 05:51:43 INFO - Return code: 0 05:51:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:43 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 0x103ccca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d61618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa941593d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c30d30>, '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 0x103995db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c28b20>, '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.uOjtYYgBh1/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.MvdrBawwiL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 05:51:43 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 05:51:43 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 05:51:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uOjtYYgBh1/Render', 05:51:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:51:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:51:43 INFO - 'HOME': '/Users/cltbld', 05:51:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:51:43 INFO - 'LOGNAME': 'cltbld', 05:51:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:43 INFO - 'MOZ_NO_REMOTE': '1', 05:51:43 INFO - 'NO_EM_RESTART': '1', 05:51:43 INFO - 'PAGER': '/bin/cat', 05:51:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:51:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:43 INFO - 'PWD': '/builds/slave/test', 05:51:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:51:43 INFO - 'SHELL': '/bin/bash', 05:51:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MvdrBawwiL/Listeners', 05:51:43 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 05:51:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:51:43 INFO - 'USER': 'cltbld', 05:51:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:51:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:51:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:43 INFO - 'XPC_FLAGS': '0x0', 05:51:43 INFO - 'XPC_SERVICE_NAME': '0', 05:51:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:51:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:43 INFO - Downloading/unpacking jsonschema==2.5.1 05:51:43 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 05:51:43 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 05:51:43 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 05:51:43 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 05:51:43 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 05:51:43 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 05:51:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:51:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:51:46 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 05:51:46 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 05:51:46 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 05:51:46 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 05:51:46 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 05:51:46 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 05:51:46 INFO - Downloading functools32-3.2.3-2.tar.gz 05:51:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:51:46 INFO - warning: no files found matching '*.txt' 05:51:46 INFO - no previously-included directories found matching 'build' 05:51:46 INFO - no previously-included directories found matching 'dist' 05:51:46 INFO - no previously-included directories found matching '.git*' 05:51:46 INFO - Installing collected packages: jsonschema, functools32 05:51:46 INFO - Running setup.py install for functools32 05:51:46 INFO - warning: no files found matching '*.txt' 05:51:46 INFO - no previously-included directories found matching 'build' 05:51:46 INFO - no previously-included directories found matching 'dist' 05:51:46 INFO - no previously-included directories found matching '.git*' 05:51:46 INFO - Successfully installed jsonschema functools32 05:51:46 INFO - Cleaning up... 05:51:46 INFO - Return code: 0 05:51:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:51:46 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')]} 05:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:46 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')]} 05:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:46 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 0x103ccca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d61618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa941593d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c30d30>, '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 0x103995db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c28b20>, '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.uOjtYYgBh1/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.MvdrBawwiL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 05:51:46 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 05:51:46 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 05:51:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uOjtYYgBh1/Render', 05:51:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:51:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:51:46 INFO - 'HOME': '/Users/cltbld', 05:51:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:51:46 INFO - 'LOGNAME': 'cltbld', 05:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:46 INFO - 'MOZ_NO_REMOTE': '1', 05:51:46 INFO - 'NO_EM_RESTART': '1', 05:51:46 INFO - 'PAGER': '/bin/cat', 05:51:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:46 INFO - 'PWD': '/builds/slave/test', 05:51:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:51:46 INFO - 'SHELL': '/bin/bash', 05:51:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MvdrBawwiL/Listeners', 05:51:46 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 05:51:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:51:46 INFO - 'USER': 'cltbld', 05:51:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:51:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:46 INFO - 'XPC_FLAGS': '0x0', 05:51:46 INFO - 'XPC_SERVICE_NAME': '0', 05:51:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:51:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:51:47 INFO - Cleaning up... 05:51:47 INFO - Return code: 0 05:51:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:51: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')]} 05:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51: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')]} 05:51:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51: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', '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 0x103ccca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d61618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa941593d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c30d30>, '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 0x103995db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c28b20>, '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.uOjtYYgBh1/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.MvdrBawwiL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 05:51: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:51: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 blobuploader==1.2.4 05:51:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uOjtYYgBh1/Render', 05:51:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:51:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:51:47 INFO - 'HOME': '/Users/cltbld', 05:51:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:51:47 INFO - 'LOGNAME': 'cltbld', 05:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:47 INFO - 'MOZ_NO_REMOTE': '1', 05:51:47 INFO - 'NO_EM_RESTART': '1', 05:51:47 INFO - 'PAGER': '/bin/cat', 05:51:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:47 INFO - 'PWD': '/builds/slave/test', 05:51:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:51:47 INFO - 'SHELL': '/bin/bash', 05:51:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MvdrBawwiL/Listeners', 05:51:47 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 05:51:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:51:47 INFO - 'USER': 'cltbld', 05:51:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:51:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:47 INFO - 'XPC_FLAGS': '0x0', 05:51:47 INFO - 'XPC_SERVICE_NAME': '0', 05:51:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:51:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:47 INFO - Downloading/unpacking blobuploader==1.2.4 05:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:49 INFO - Downloading blobuploader-1.2.4.tar.gz 05:51:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:51:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:51:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:51:50 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 05:51:50 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 05:51:50 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 05:51:50 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 05:51:50 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 05:51:50 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 05:51:50 INFO - Downloading docopt-0.6.1.tar.gz 05:51:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:51:51 INFO - Installing collected packages: blobuploader, requests, docopt 05:51:51 INFO - Running setup.py install for blobuploader 05:51:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:51:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:51:51 INFO - Running setup.py install for requests 05:51:51 INFO - Running setup.py install for docopt 05:51:51 INFO - Successfully installed blobuploader requests docopt 05:51:51 INFO - Cleaning up... 05:51:51 INFO - Return code: 0 05:51:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:51:51 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')]} 05:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:51 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')]} 05:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:51 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 0x103ccca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d61618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa941593d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c30d30>, '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 0x103995db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c28b20>, '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.uOjtYYgBh1/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.MvdrBawwiL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 05:51:51 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 05:51:51 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 05:51:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uOjtYYgBh1/Render', 05:51:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:51:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:51:51 INFO - 'HOME': '/Users/cltbld', 05:51:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:51:51 INFO - 'LOGNAME': 'cltbld', 05:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:51 INFO - 'MOZ_NO_REMOTE': '1', 05:51:51 INFO - 'NO_EM_RESTART': '1', 05:51:51 INFO - 'PAGER': '/bin/cat', 05:51:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:51 INFO - 'PWD': '/builds/slave/test', 05:51:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:51:51 INFO - 'SHELL': '/bin/bash', 05:51:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MvdrBawwiL/Listeners', 05:51:51 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 05:51:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:51:51 INFO - 'USER': 'cltbld', 05:51:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:51:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:51 INFO - 'XPC_FLAGS': '0x0', 05:51:51 INFO - 'XPC_SERVICE_NAME': '0', 05:51:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:51:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:51:52 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-PEiNYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:51:52 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-ntURMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:51:52 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-AhHgy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:51:52 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-wy2HYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:51:52 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-m3xZ2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:51:52 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-2qnccr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:51:52 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-fGwHhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:51:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:51:52 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-x_qKvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:51:53 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-xbJm6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:51:53 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-uSKl0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:51:53 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-liOV6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:51:53 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-RvLoFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:51:53 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-PFt006-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:51:53 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-4n8yg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:53 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-OJlk_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:51:53 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-cg1LZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:51:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:51:53 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-ZECI2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:51:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:51:54 INFO - Running setup.py install for manifestparser 05:51:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:51:54 INFO - Running setup.py install for mozcrash 05:51:54 INFO - Running setup.py install for mozdebug 05:51:54 INFO - Running setup.py install for mozdevice 05:51:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:51:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:51:54 INFO - Running setup.py install for mozfile 05:51:54 INFO - Running setup.py install for mozhttpd 05:51:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:51:54 INFO - Running setup.py install for mozinfo 05:51:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:51:55 INFO - Running setup.py install for mozInstall 05:51:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:51:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:51:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:51:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:51:55 INFO - Running setup.py install for mozleak 05:51:55 INFO - Running setup.py install for mozlog 05:51:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:51:55 INFO - Running setup.py install for moznetwork 05:51:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:51:55 INFO - Running setup.py install for mozprocess 05:51:55 INFO - Running setup.py install for mozprofile 05:51:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:51:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:51:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:51:56 INFO - Running setup.py install for mozrunner 05:51:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:51:56 INFO - Running setup.py install for mozscreenshot 05:51:56 INFO - Running setup.py install for moztest 05:51:56 INFO - Running setup.py install for mozversion 05:51:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:51:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:51:56 INFO - Cleaning up... 05:51:56 INFO - Return code: 0 05:51:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:51:56 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')]} 05:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:56 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')]} 05:51:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:56 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 0x103ccca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d61618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa941593d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c30d30>, '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 0x103995db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c28b20>, '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.uOjtYYgBh1/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.MvdrBawwiL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 05:51:56 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 05:51:56 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 05:51:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uOjtYYgBh1/Render', 05:51:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:51:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:51:56 INFO - 'HOME': '/Users/cltbld', 05:51:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:51:56 INFO - 'LOGNAME': 'cltbld', 05:51:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:56 INFO - 'MOZ_NO_REMOTE': '1', 05:51:56 INFO - 'NO_EM_RESTART': '1', 05:51:56 INFO - 'PAGER': '/bin/cat', 05:51:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:51:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:56 INFO - 'PWD': '/builds/slave/test', 05:51:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:51:56 INFO - 'SHELL': '/bin/bash', 05:51:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MvdrBawwiL/Listeners', 05:51:56 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 05:51:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:51:56 INFO - 'USER': 'cltbld', 05:51:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:51:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:51:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:56 INFO - 'XPC_FLAGS': '0x0', 05:51:56 INFO - 'XPC_SERVICE_NAME': '0', 05:51:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:51:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:51:56 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-Pc9oKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:51:57 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)) 05:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:51:57 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-PGa1AX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:51:57 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)) 05:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:51:57 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-gQYkjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:51:57 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)) 05:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:51:57 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-1pHxA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:51:57 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)) 05:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:51:57 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-JauxJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:51:57 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)) 05:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:51:57 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-rcklqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:51:57 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)) 05:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:51:57 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-wMUaVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:51:57 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)) 05:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:51:57 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-QZ5zDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:51:57 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)) 05:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:51:57 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-UU74m3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:51:57 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)) 05:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:51:57 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-mDfkPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:51:58 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)) 05:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:51:58 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-qqEufV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:51:58 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)) 05:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:51:58 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-efqHWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:51:58 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)) 05:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:51:58 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-RDtPYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:51:58 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)) 05:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:51:58 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-hwJg95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:51:58 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)) 05:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:58 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-FUNM7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:58 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)) 05:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:51:58 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-Z0De9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:51:58 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)) 05:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:51:58 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-vwtOPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:51:58 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)) 05:51:58 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)) 05:51:58 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)) 05:51:58 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)) 05:51:58 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)) 05:51:58 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)) 05:51:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:52:01 INFO - Downloading blessings-1.6.tar.gz 05:52:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:52:01 INFO - Installing collected packages: blessings 05:52:01 INFO - Running setup.py install for blessings 05:52:01 INFO - Successfully installed blessings 05:52:01 INFO - Cleaning up... 05:52:01 INFO - Return code: 0 05:52:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:52:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:52:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:52:01 INFO - Reading from file tmpfile_stdout 05:52:01 INFO - Current package versions: 05:52:01 INFO - blessings == 1.6 05:52:01 INFO - blobuploader == 1.2.4 05:52:01 INFO - docopt == 0.6.1 05:52:01 INFO - functools32 == 3.2.3-2 05:52:01 INFO - jsonschema == 2.5.1 05:52:01 INFO - manifestparser == 1.1 05:52:01 INFO - mozInstall == 1.12 05:52:01 INFO - mozcrash == 0.17 05:52:01 INFO - mozdebug == 0.1 05:52:01 INFO - mozdevice == 0.48 05:52:01 INFO - mozfile == 1.2 05:52:01 INFO - mozhttpd == 0.7 05:52:01 INFO - mozinfo == 0.9 05:52:01 INFO - mozleak == 0.1 05:52:01 INFO - mozlog == 3.3 05:52:01 INFO - moznetwork == 0.27 05:52:01 INFO - mozprocess == 0.23 05:52:01 INFO - mozprofile == 0.28 05:52:01 INFO - mozrunner == 6.12 05:52:01 INFO - mozscreenshot == 0.1 05:52:01 INFO - mozsystemmonitor == 0.3 05:52:01 INFO - moztest == 0.7 05:52:01 INFO - mozversion == 1.4 05:52:01 INFO - psutil == 3.1.1 05:52:01 INFO - requests == 1.2.3 05:52:01 INFO - wsgiref == 0.1.2 05:52:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:01 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 0x103ccca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d61618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa941593d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c30d30>, '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 0x103995db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c28b20>, '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.uOjtYYgBh1/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.MvdrBawwiL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 05:52:01 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 05:52:01 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 05:52:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uOjtYYgBh1/Render', 05:52:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:01 INFO - 'HOME': '/Users/cltbld', 05:52:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:01 INFO - 'LOGNAME': 'cltbld', 05:52:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:01 INFO - 'MOZ_NO_REMOTE': '1', 05:52:01 INFO - 'NO_EM_RESTART': '1', 05:52:01 INFO - 'PAGER': '/bin/cat', 05:52:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:01 INFO - 'PWD': '/builds/slave/test', 05:52:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:01 INFO - 'SHELL': '/bin/bash', 05:52:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MvdrBawwiL/Listeners', 05:52:01 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 05:52:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:01 INFO - 'USER': 'cltbld', 05:52:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:01 INFO - 'XPC_FLAGS': '0x0', 05:52:01 INFO - 'XPC_SERVICE_NAME': '0', 05:52:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:02 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)) 05:52:02 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)) 05:52:02 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)) 05:52:02 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)) 05:52:02 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)) 05:52:02 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)) 05:52:02 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)) 05:52:02 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)) 05:52:02 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)) 05:52:02 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)) 05:52:02 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)) 05:52:02 INFO - Cleaning up... 05:52:02 INFO - Return code: 0 05:52:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:52:02 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')]} 05:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:02 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')]} 05:52:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:02 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 0x103ccca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d61618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa941593d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c30d30>, '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 0x103995db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c28b20>, '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.uOjtYYgBh1/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.MvdrBawwiL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 05:52:02 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 05:52:02 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 05:52:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uOjtYYgBh1/Render', 05:52:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:02 INFO - 'HOME': '/Users/cltbld', 05:52:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:02 INFO - 'LOGNAME': 'cltbld', 05:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:02 INFO - 'MOZ_NO_REMOTE': '1', 05:52:02 INFO - 'NO_EM_RESTART': '1', 05:52:02 INFO - 'PAGER': '/bin/cat', 05:52:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:02 INFO - 'PWD': '/builds/slave/test', 05:52:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:02 INFO - 'SHELL': '/bin/bash', 05:52:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MvdrBawwiL/Listeners', 05:52:02 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 05:52:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:02 INFO - 'USER': 'cltbld', 05:52:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:02 INFO - 'XPC_FLAGS': '0x0', 05:52:02 INFO - 'XPC_SERVICE_NAME': '0', 05:52:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:52:02 INFO - Cleaning up... 05:52:02 INFO - Return code: 0 05:52:02 INFO - Running post-action listener: _resource_record_post_action 05:52:02 INFO - Running post-action listener: _start_resource_monitoring 05:52:02 INFO - Starting resource monitoring. 05:52:02 INFO - [mozharness: 2016-08-08 12:52:02.532083Z] Finished create-virtualenv step (success) 05:52:02 INFO - [mozharness: 2016-08-08 12:52:02.533055Z] Running install step. 05:52:02 INFO - Running pre-action listener: _resource_record_pre_action 05:52:02 INFO - Running main action method: install 05:52:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:52:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:52:02 INFO - Reading from file tmpfile_stdout 05:52:02 INFO - Detecting whether we're running mozinstall >=1.0... 05:52:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:52:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:52:02 INFO - Reading from file tmpfile_stdout 05:52:02 INFO - Output received: 05:52:02 INFO - Usage: mozinstall [options] installer 05:52:02 INFO - Options: 05:52:02 INFO - -h, --help show this help message and exit 05:52:02 INFO - -d DEST, --destination=DEST 05:52:02 INFO - Directory to install application into. [default: 05:52:02 INFO - "/builds/slave/test"] 05:52:02 INFO - --app=APP Application being installed. [default: firefox] 05:52:02 INFO - mkdir: /builds/slave/test/build/application 05:52:02 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'] 05:52:02 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 05:52:37 INFO - Reading from file tmpfile_stdout 05:52:37 INFO - Output received: 05:52:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:52:37 INFO - Running post-action listener: _resource_record_post_action 05:52:37 INFO - [mozharness: 2016-08-08 12:52:37.437908Z] Finished install step (success) 05:52:37 INFO - [mozharness: 2016-08-08 12:52:37.438061Z] Running run-tests step. 05:52:37 INFO - Running pre-action listener: _resource_record_pre_action 05:52:37 INFO - Running main action method: run_tests 05:52:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:52:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:52:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:52:37 INFO - 2016-08-08 05:52:37.451 screenresolution[2943:86992] starting screenresolution argv=screenresolution get 05:52:37 INFO - 2016-08-08 05:52:37.454 screenresolution[2943:86992] Display 0: 1600x1200x32@60 05:52:37 INFO - 2016-08-08 05:52:37.459 screenresolution[2944:86994] starting screenresolution argv=screenresolution list 05:52:37 INFO - Available Modes on Display 0 05:52:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:52:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:52:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:52:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:52:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:52:37 INFO - Intel Iris: 05:52:37 INFO - Chipset Model: Intel Iris 05:52:37 INFO - Type: GPU 05:52:37 INFO - Bus: Built-In 05:52:37 INFO - VRAM (Dynamic, Max): 1536 MB 05:52:37 INFO - Vendor: Intel (0x8086) 05:52:37 INFO - Device ID: 0x0a2e 05:52:37 INFO - Revision ID: 0x0009 05:52:37 INFO - Displays: 05:52:37 INFO - Display: 05:52:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:52:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:52:37 INFO - Display Serial Number: 1600x1200 60 05:52:37 INFO - Main Display: Yes 05:52:37 INFO - Mirror: Off 05:52:37 INFO - Online: Yes 05:52:37 INFO - Rotation: Supported 05:52:37 INFO - Return code: 0 05:52:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:52:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:52:37 INFO - Python 2.7.3 05:52:37 INFO - Return code: 0 05:52:37 INFO - grabbing minidump binary from tooltool 05:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:37 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 0x103c30d30>, '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 0x103995db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103c28b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:52:37 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 05:52:37 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 05:52:37 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 05:52:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:52:37 INFO - Return code: 0 05:52:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:52:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:52:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:52:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:52:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:52:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MrLTufnlSjSGjQZ3NLyTHg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0259', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:52:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MrLTufnlSjSGjQZ3NLyTHg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0259 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:52:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uOjtYYgBh1/Render', 05:52:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:37 INFO - 'HOME': '/Users/cltbld', 05:52:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:37 INFO - 'LOGNAME': 'cltbld', 05:52:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:52:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:52:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:37 INFO - 'MOZ_NO_REMOTE': '1', 05:52:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:52:37 INFO - 'NO_EM_RESTART': '1', 05:52:37 INFO - 'PAGER': '/bin/cat', 05:52:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:37 INFO - 'PWD': '/builds/slave/test', 05:52:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:52:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:37 INFO - 'SHELL': '/bin/bash', 05:52:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MvdrBawwiL/Listeners', 05:52:37 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 05:52:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:37 INFO - 'USER': 'cltbld', 05:52:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:37 INFO - 'XPC_FLAGS': '0x0', 05:52:37 INFO - 'XPC_SERVICE_NAME': '0', 05:52:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MrLTufnlSjSGjQZ3NLyTHg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0259', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:52:38 INFO - mozversion application_buildid: 20160808030450 05:52:38 INFO - mozversion application_changeset: 1a72f2737bce150bd90c831341cc7b5a93fc2aa9 05:52:38 INFO - mozversion application_display_name: Nightly 05:52:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:52:38 INFO - mozversion application_name: Firefox 05:52:38 INFO - mozversion application_remotingname: firefox 05:52:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:52:38 INFO - mozversion application_vendor: Mozilla 05:52:38 INFO - mozversion application_version: 51.0a1 05:52:38 INFO - mozversion platform_buildid: 20160808030450 05:52:38 INFO - mozversion platform_changeset: 1a72f2737bce150bd90c831341cc7b5a93fc2aa9 05:52:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:52:38 INFO - mozversion platform_version: 51.0a1 05:52:38 INFO - using testdate: 1470660758 05:52:38 INFO - actual date: 1470660758 05:52:38 INFO - starting webserver on 'localhost:49765' 05:52:38 INFO - SUITE-START | Running 2 tests 05:52:38 INFO - TEST-START | dromaeo_css 05:52:38 INFO - operating with platform_type : mac_ 05:52:38 INFO - Initialising browser for dromaeo_css test... 05:52:38 INFO - TEST-INFO | started process 2954 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmpRW6sKm/profile http://localhost:49765/getInfo.html) 05:52:40 INFO - PROCESS | 2954 | __metrics Screen width/height:1600/1200 05:52:40 INFO - PROCESS | 2954 | colorDepth:24 05:52:40 INFO - PROCESS | 2954 | Browser inner width/height: 1024/689 05:52:40 INFO - PROCESS | 2954 | __metrics 05:52:40 ERROR - PROCESS | 2954 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:52:41 INFO - TEST-INFO | 2954: exit 0 05:52:41 INFO - Browser initialized. 05:52:41 INFO - Running cycle 1/1 for dromaeo_css test... 05:52:41 INFO - TEST-INFO | started process 2957 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmpRW6sKm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:52:53 INFO - PROCESS | 2957 | RSS: Main: 254988288 05:52:53 INFO - PROCESS | 2957 | 05:53:43 INFO - PROCESS | 2957 | 1470660823484 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] 05:55:55 INFO - PROCESS | 2957 | Cycle 1(1): loaded http://localhost:49765/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49765/tests/dromaeo/cssquery-ext.html) 05:55:57 INFO - PROCESS | 2957 | RSS: Main: 267755520 05:55:57 INFO - PROCESS | 2957 | 05:58:59 INFO - PROCESS | 2957 | Cycle 1(1): loaded http://localhost:49765/tests/dromaeo/cssquery-ext.html (next: http://localhost:49765/tests/dromaeo/cssquery-jquery.html) 05:59:00 INFO - PROCESS | 2957 | RSS: Main: 280604672 05:59:00 INFO - PROCESS | 2957 | 06:02:02 INFO - PROCESS | 2957 | Cycle 1(1): loaded http://localhost:49765/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49765/tests/dromaeo/cssquery-mootools.html) 06:02:02 INFO - PROCESS | 2957 | RSS: Main: 287932416 06:02:02 INFO - PROCESS | 2957 | 06:05:04 INFO - PROCESS | 2957 | Cycle 1(1): loaded http://localhost:49765/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49765/tests/dromaeo/cssquery-prototype.html) 06:05:05 INFO - PROCESS | 2957 | RSS: Main: 288374784 06:05:05 INFO - PROCESS | 2957 | 06:08:08 INFO - PROCESS | 2957 | Cycle 1(1): loaded http://localhost:49765/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49765/tests/dromaeo/cssquery-yui.html) 06:08:08 INFO - PROCESS | 2957 | RSS: Main: 292655104 06:08:08 INFO - PROCESS | 2957 | 06:11:11 INFO - PROCESS | 2957 | Cycle 1(1): loaded http://localhost:49765/tests/dromaeo/cssquery-yui.html (next: http://localhost:49765/tests/dromaeo/cssquery-dojo.html) 06:11:11 INFO - PROCESS | 2957 | RSS: Main: 292544512 06:11:11 INFO - PROCESS | 2957 | 06:11:11 INFO - PROCESS | 2957 | __start_tp_report 06:11:11 INFO - PROCESS | 2957 | _x_x_mozilla_page_load 06:11:11 INFO - PROCESS | 2957 | _x_x_mozilla_page_load_details 06:11:11 INFO - PROCESS | 2957 | |i|pagename|runs| 06:11:11 INFO - PROCESS | 2957 | |0;dojo.html;3418.52140700302;3443.190850150215;3455.8790442334525;3460.7058400035994;3490.598581163167;5806.854828629286;5892.941070589292;5930.52555795537;5989.221401217841;5989.251343582052;5897.557683173768;5913.2017177681;5925.73334199962;5980.491658209057;6046.54650901182;5253.159494480884;5356.276902618155;5397.7031263280505;5398.2982212312545;5399.136138217886;5187.3775146982225;5295.0468915595175;5417.864553386157;5428.565714742811;5442.156465747816;5321.627486075976;5370.570354371641;5382.300300960889;5397.082495975694;5428.864278393033;5371.811986580451;5382.381026181961;5384.434634363374;5399.487048730364;5401.351837779453;4304.870853874389;5224.63427560071;5228.79084836606;5294.708791016493;5388.326459192601;5703.74333155009;5850.151727999416;5975.19334889793;6010.57925945184;6055.757769689207;6243.355754041179;6244.781432649836;6291.276503202099;6298.527610429236;6313;6118.3146263159115;6248.31268560458;6263.43629073381;6359.55483116182;6364.681765911732;5639.154126881001;6087.391260873966;6101.145839582462;6126.8230438726505;6143.723532441051;6453.645049522227;6489.772857949949;6490.286068532458;6503.479721622353;6566.1135746674545;6113.050656958994;6205.689715514206;6240.563160578716;6312.621242725451;6338.809835704937;5359.892802143935;6248.968755156286;6301.7164227609865;6373.808785736435;6377.394147555975;6261.092141639437;6277.403646653652;6288.654124023223;6296.024116261987;6327.462165715873;6145.586515101551;6232.345603711636;6298.527610429144;6308.905366419507;6324.367563243731;5002.2496625506465;5056.974715126401;5059.620528460307;5096.464871188546;5104.1067813133295;4513.54864513546;4524.09518096382;4539.931901021488;4577.0159415725775;4600.217962946307;5949.434803693643;6023.728932197974;6066.241719785027;6099.908501372394;6109.297430795426;6262.3111457739615;6388.744450222032;6401.519886008475;6407.583507072119;6433.485321174388;6077.878442431127;6085.36103709113;6133.84665383369;6139.171211886338;6150.138980542728;5420.4850539198715;5532.7786888524815;5596.188552659842;5597.832065038056;5673.149027645886;6424.421802037839;6519.380658837403;6521.8695626088165;6539.934600654123;6545.214574251025;6391.808245752635;6396.072569477493;6397.392247736458;6425.293217746138;6472.546921715435;6304.369563043842;6399.264084630141;6534.313897040743;6541;6548.246951600627;6192.59748116371;6242.937570624417;6295.464885484602;6316.368363163647;6330.272018717907;5107.642465027561;6131.693415329127;6351.428371446592;6369.299377068612;6373.362663733589;6119.807225076679;6172.475339596184;6255.218097737783;6266.561340706289;6288.779892703734;6184.567080304336;6225.00399936008;6253.187085678833;6253.96873015632;6254.2807577129215;5953.166556682155;6166.075088736546;6168.753249870135;6203.4416902479;6222.937770622236;6129.049997250433;6158.230221222348;6267;6270.623762574078;6274.058891166179;6096.055111457731;6135.1717518136265;6145.201123854049;6147.9855823788575;6148.739508400857 06:11:11 INFO - PROCESS | 2957 | |1;ext.html;455.1579577781104;474.5515487863968;511.7927239468017;533.5918022712623;556.6103727390824;35081.29837403251;35286;40003.79998100009;40197.79901100498;40248.79253622396;41089.38365924513;41158.794206029;41599.37600935988;41641;41691.37462938051;9577.377470464415;9742.318037737361;9754.707358779247;9789.90210097897;9802.215822734164;8750.431221970552;9490.288228382864;9739.123478886899;9817.263705222102;9842.212622990144;9831.754206144831;9837.163841073518;9875.802483950316;9881.456519891439;9885.0609192127;9777.315587908814;9812.95093524535;9819.214462842956;9823.754406139833;9856.802863942752;9621.711348659552;9708.854367184498;9711.174550163245;9720.708378748648;9723.222142228604;39146.804265978775;39542.60457395418;39563;39618;39626.009349766195;3085.598872146629;3496.230829217568;3620.275944811022;3957.6240257175523;4286.485621725382;31017;31559.233017886294;31681.049568512983;31835.88574399885;31951;3138.6233651961684;3219.6941290577356;3344.2642618623863;3366.848491817874;3376.4766461198556;421231;504272;517591;518939.40530297486;519558;48925;58325.416745832845;58607.70696146492;58690;58770.11844822331;48754;58988;59508.7024564883;59556.40443595508;59561;16002.75995860063;16111;16200;16214.75677864833;16233.83766162347;12166.756664866652;12622.684432889251;12654.87345126537;12664.74670506603;12699.301538415475;14536.709265814625;15848.60378490547;15921.761173582405;15973.840261597468;15981.121038343003;7150.923973335149;7169.713211471482;7260.564366138048;7304.735531985101;7340.559566426032;868.6699054359303;899.955002249898;1011.9645812396531;1075.2365820267698;1080.524569189554;26474.6028809568;28930.421391572472;29952.40095198084;30342;30530.38939221203;1021.8467229915424;1056.9641751083827;1139.5954436175205;1174.8296497007887;1184.810430331143;15517.689646207013;15598.98606590568;15691.921540392224;15883.682326353408;16028.358865645243;718992;725957;726936;727841.3607931926;727952;58884.705576471846;59139;59604;59780;59836.10245846316;1349.9122557033959;1366.1598117157876;1380.4685196199534;1383.156274672449;1386.9098508596908;28000.019999299926;29086;29590.704092959655;29970;30147.944821931127;49827.25259121189;50532.49467505278;50590.711603745636;50619.74690126526;50949.49050509447;635591;639528;640600;640847;641166;26235.21294361172;26417.60373594436;26662.466750665266;27033;27039.783209755216;46798.53201467942;47455;47494.76252618715;48461.27308090311;48880.26679599738;37789.43315850209;38630.42054369243;38859.41710874395;39549.80225098856;41039.38440923329;29430.264243394085;39092.6090739089;39572.2085558293;40373.394399084624;40726.79636601798;37244.627553724116;37389.06527336838;38138.80930595329;38261.808690956364;38527.807360963016;33524;34437.48343774895;34698.65301346954;35706.821465892506;35949.38227779704;23413.882930585238;23427;23699.289021329387;23835.880820595787;26202 06:11:11 INFO - PROCESS | 2957 | |2;jquery.html;290.75721772320117;348.24778478486473;370.78679759138504;391.0575513013636;394.500956290293;19865.20539178433;19891.403257902268;21005.47486312841;21320.36038918835;21350.252741154025;11464.426778661074;11920.046396288299;20227.887466189353;21285.467863303387;21311.467213319676;5416.485433883785;5487.149491828773;5585.972070139644;5617;5634.690092044936;5359.598030147735;5423.918641220365;5440.265564148829;5498.615096943216;5515.641483303572;5485.122380419134;5508.394076651565;5518.310211223597;5520.641158324696;5524.861878453051;5291.4708529147165;5386.946130538684;6018.638881667114;6034.63792172471;6043.002904520748;5275.736213189363;5323.893522129574;5332.373626044055;5335.813246536352;5351.2240725095035;13491;13616.114952528153;21284.893575532024;24949.251522454357;26210.213693589223;2365.47959448921;2391.4021494626345;2425.6240282756203;2580.8709564521887;2867.197184788242;10112.938141495111;10334.793304133875;12089.516419343216;12800.935995320056;15221.934464587483;1755.7893052833742;1826.4520643806804;1867.6544839204792;1885.5474686075381;1902.6384986852593;107944.46027769889;119762.4011879935;126357;127667;128275;11311.434428278717;11336.829947550794;11670.591529296435;11722;11956.641300760992;14812.70374592502;14817.77773333401;14823.110613363233;14828.036177648419;14868.182249976355;7810;7981.922440470578;8293;8604.268637165911;8726.65093396257;8469.5341756204;8477.194666506672;8540.231379175904;8558.871616925751;8640.179182977607;4082.265192265421;4156.771377574262;4363.825446982085;4486.967997360625;4521.525239849834;1882.7364169016348;1928.3443629166152;1938.7285779990812;1955.9706604400944;1959;817.7955511122219;866.5104216117874;970.6507953944024;1001.0940099210227;1044.7910417916446;21324.253651122446;21751.564968700855;21813;21837.126514939224;21886.23398181056;870.991290087091;902.3367824648877;964.3008818606594;986.4278718343344;1020.7142000239945;8210.794730131674;9176.17414432691;9695.466749328714;10945.4527273636;11208.262719278526;564291;568195.1590242023;570663;582837;583849;115659.42170289264;130254;134969.32515337362;146844;149226;831.6340810043562;975.3221511049752;1028.4960369418932;1044.5769463367349;1056.772793849326;19185.90407047956;19945.70567703876;19966.52594239476;20173.49566260855;20443.38669839907;53501.464985349645;56485.8702825933;56990.71504642616;57106.7144664274;57767;75232;79364;79850;83112.58443707743;87337;7935;8106.189381061847;8112.959435202786;8466.619002145042;8560.186782255676;8681.609327580149;12409.689757756129;13224.801627975396;13661.658458538615;13883.305834708022;11508.251963622337;11684.357360345262;11839.644810655349;11905.345206013752;12001.63995080149;9310.906890931004;9705.854412183682;11061.668149955514;11179.329240245612;11831.290122592673;11335.659930202108;11701.473433695674;11876;11981.400929953641;12043.09676774228;6837.62393068386;6891.483138764513;8456.492610443393;8483.618237179466;8602;9902.405855648683;11546.884531154581;11795.941020295188;11979.221350612183;12034.699132521757 06:11:11 INFO - PROCESS | 2957 | |3;mootools.html;1468.5520916120581;1527.274544591319;1724.6550689862022;1836.6602178596952;1846.6306738652272;7838.333741631968;8300.875486867695;8431.40980131391;8886.422382545146;8889.777755556106;8578.22795948366;8795.516246606434;8798.604062817172;8823.735287941356;8843.806086178363;2343.8359314847967;2380.6429035644705;2381.654660074288;2388.4267775733874;2395.993682653281;2095.3504413631745;2327.5461285049423;2331.6502524621274;2365;2386.940326491834;2337.649352597107;2337.9766202338014;2347.225415612852;2352.6000579901374;2359.7758212969825;2316.6756654068445;2320.4662927526597;2333.8249631277636;2345.812335013195;2348.002099107881;2330.265966220652;2330.9184178553837;2335.94160145996;2340.157543284416;2340.4265954841003;8660.566971651393;8831.381803273773;8870.024297327289;8883.42257753244;8896.19934205918;5159.587233021387;5189.143791274435;5304.443033481468;5323.281357016831;5328.573714102862;3479.373712731707;3554.0759402555523;3620.5112309838096;3625.7099432045375;3643.0892276930767;1043.546057465005;1071.50175168547;1090.2967585907045;1105.4748994227677;1108.384846410242;10472.476376181237;11008.339499630049;11587.015103716194;11630.418479076012;11753.764924701543;4522.5929666330185;4703.835365762182;4800.135975524369;4806.49531799163;4829.830955916596;9877.851832222523;9946.00539946014;9951.502424878727;9959.103680668775;9983.500824958723;5322.4411436799355;5342.679439233659;5348.9732551337775;5356.651817631841;5362.51737343641;3810.047488127968;4695.201815691341;4862.927056094161;4884.267359896044;4892.535209155125;3917.9020524486546;3955.2880481513603;4002.45966794479;4029.738067025634;4065.329220678614;1286.7490839286436;1288.5683296095726;1294.4239813283186;1295.9676008099873;1296.598054603076;804.7022601637432;810.631162820915;884.5754038061766;888.2228050455851;925.4169872980115;5835.299764028344;5871.853203669943;6088.056351265561;6128.3565225651555;6274.560780745304;432.2629915993224;437.4422611170719;441.5341814385854;446.08329882092613;452.8279253883503;3690.797006164633;3974.463447434617;3999;4070.7964601769795;4132.896677583084;10451;10827.079698225582;10858.34849909008;10877.619283325046;10882.836757448644;10794.676159715222;10808.675739727822;10808.78382432347;10818.729531761612;10886.183536234814;7116.964415177891;8203.220694034057;8302.418830681914;8331.12523185069;8336.958315208385;5019.62352823547;5223.373195216598;5366.248725178556;5765.884682306247;6068.575199736153;8459.619317130868;10028.448435336126;10099.242556808416;10140.340877842917;10145.49272536385;9836.901630983599;10298.845517317097;10307.94846025765;10324;10349.63776267827;6920.5847649141215;7285.890711639436;7414.22150674193;7572.20491848348;7644.847103058019;8445.493270403795;8506.489610623383;8519.062903080532;8535.701250456204;8546.572671366532;7319.560826350223;7440.516366436164;7558.433117516099;7584;7711.922880771345;7210.639468026683;7221.241769614325;7333.230010848997;7340.743073992385;7466.925330746841;6974.79075627732;6984.301569842975;7028.121484814398;7066.4700147490175;7074.858502829811;4885.145099607484;4961.7271050092595;5045.62157838171;5103.209002604603;5133.614978876674;4193.517745459311;4504.572065653758;4690.413698287714;4836.564709176191;5004.049230646166 06:11:11 INFO - PROCESS | 2957 | |4;prototype.html;265.8657378024098;298.3674609827165;304.53406288378784;314.1956591126716;314.5517637366752;4230.873073807791;4404.537523560024;5454.91817622736;5729.713514324283;5749.5687823413255;4646.907061858761;5210.583153347732;5627.184058311543;5642.4357564243655;5647.971760141194;4329.047609525907;4330.675199360045;4348.326009468537;4350.456192975878;4369.388285639997;3479.425894727367;3770.8491660333552;3870.9548421926065;3981.805458362494;4228.175505776375;4186.079062606222;4199.517055538621;4205.222033923718;4206.768627725474;4211.504915754909;3528.6824185823143;3850.4224366345134;4214.3889136075095;4224.218519573888;4261.87214383569;3648.689861361761;3649.7262705297208;3650.4159334506353;3666.1934374437583;3667.2665466906724;5390.218418329359;5486.698231597261;5494.532964698005;5507.228987941651;5528.419515950848;4190.706650534464;4719.480857105716;4829.348038014893;4855.198892182786;4905.362302900636;5129.512696293846;5625.774969001235;5717.714114294268;5996.580239383245;6021.277446706379;3918.2555314490155;3934;3934.704897132698;3960.4851369321805;3961.0889495415927;5477.7261136943;5994.310654274727;6179.258488981306;6222.906656400158;6289.182406287199;4045.150518391171;4047.7571345719352;4060.2082593893906;4066.1461093170174;4081.4081958115908;3766.8681596144;3978.403239514038;4044.6157615026527;4048.514178298623;4069.819752271808;4754.690945088558;4802.62270176258;4827.589654879374;4834.540718631724;4840.394950631171;4914.582260507826;5969;6072.726727297282;6079.787207447806;6086.756529738761;1317.3610798762593;1341.4097796969302;1342.241633477102;1389.249805105252;1409.4362255097838;722.147865518693;819.315871247515;834.561855026104;845.564534264854;852.7356519478982;4012.1574469361176;4160.646345060643;4428.4500424851685;4614.400127983407;4710.929336059962;4435.735815292691;5105.315245968895;5151.553012319118;5180.326557547494;5193.37679478465;4185.751462265803;4396.978015109904;4688.64835137366;4725.669203155746;4752.5485078917445;2167.8482506224414;2402.6756387887413;2651.9602205966926;2684.0471632570548;2743;5315.681059136464;5326.871674452331;5342.023451323035;5344.786208551614;5375.596830237748;4720.409948756405;4785.569298763128;5281;5286.497782710637;5289.18017707256;4793;4821.493743156918;4897;5356.91964620531;5433.402325744086;5077.949220507895;5134.302113566195;5232.659877108128;5256.424352067535;5287.233351164136;3790.5256570097376;4524.8416305429155;4910.299335365463;4941.072981537275;5199.896002079861;4629.629629629689;4923.384576927884;5211.690576484036;5259.16157135444;5341.75962081715;3555.4311310190246;3570.3573356794986;3817.312883680964;3939.3697008478507;4031.596840315945;5334.506338225303;6048.213732214784;6079.3008803988105;6147.510258345377;6164.198654174928;4861.475430312995;5199.974000129975;5956;5982.0727787193055;6035.305939816977;5386.114859799039;5535.142052981794;5704.087346024616;5968.791092311748;5979.1928089707335;5061.392632884077;5137.614678899023;5145.71698556568;5850.268716410449;5855.502282305882;5215.55667768244;5248.973755131353;5466.528754241006;5516.255305533701;5855.531557475477;5364.30264065669;5787.94212057874;5810.593258471867;5840.269966254218;5864.589478736448 06:11:11 INFO - PROCESS | 2957 | |5;yui.html;643.3984224749862;766.0960067120799;787.8384931089128;794.7933537280308;816.8243827577072;15580.610484737874;15793.368265269375;15816.683666326666;15980.520584382488;16025.278862451189;14342.856571434282;14458.132512049284;14470.782938255908;14475.638109047253;14483;674.6525539347216;833.8790875323075;834.9540775257359;864.5720368417642;873.7553485024204;740.4483659673524;858.2061593026457;873.4366333714781;875.6497401039603;875.7854325690215;904.5160838951163;928.2017464980112;931.1154403316842;931.6925414613162;933.2207606648457;890.4078787606234;902.634433054614;912.625823412401;922.9584668689926;926.6756635177701;668.3083009085622;685.5886468119138;688.3804575881696;688.4836372720459;691.3777600159846;14735.852641473555;14767.187804670739;14783.630409239748;14811.777823332659;14846.777298340534;14557.70884582313;14597.12417254968;14686.926565367105;14693.55919322422;14707.558773236713;10647.627333043383;11841;12137.02550290377;12137.453814578364;12542.874571254262;3824.6366595173413;3838.5393752749846;4030.234255491447;4071.9389209161886;4076.429299898017;116333;116582.5443757531;118599;119380;119967.4001629995;10907.454627268606;11071.889281107085;11250.549978000789;11676.357800320893;11745.941270293593;19589.412317630493;22949.54100918006;22967.770322296565;23210.955507002225;23440.531189376117;7980.122186559473;8080.757577272691;8133.10535841057;8228.958855205805;8305.418620696493;4473.4408198975125;4486.506484286726;4505.594496495266;4525.932111018337;4688.765561721969;3549.254656522159;3647.4164133738473;3663.358912190356;3664.853405863789;3668.908277293089;639.2776162935853;642.6850843086854;654.0679531667355;672.6334147889412;672.8284287506655;583.9328477225173;592.3217915486744;597.554821657859;654.852658151912;657.980260592183;8670.219680228809;8938.284937205008;9552.95223523878;9611.327207095435;9769.951150244204;568.2719771501071;625.9718312675941;627.959182653126;680.6086500262369;715.6743681624848;4441.400410944546;4580.58774710271;4863.902721945541;4877.951220487821;4899.412070551485;96258.51870740601;122707;159274;159283;162641;137017;138891.61108388787;141019;147821;148222;124101;124952;127283;127859;129964;8063.27430531255;8473.35058924454;8693.347998900234;8943;9284.72145835626;65642;65813;66326;67087.32912670811;67378;90829;98923.50538247262;103253.25600580136;108929.91070089514;108992;12019.355741736805;12027.097967652286;12222.938885305872;12559.87440125587;12751.80872286935;12649.93675031619;12984.285864277177;12985.155964862253;13024.739505209653;13131.409086591317;12254.816177757519;12274.263544187377;12302.569410070604;12309.322987235788;12564.37178141071;12317.938410307892;12424.503019879465;12449.75100497967;12510.749785004431;12593.496260149492;10009.799804004026;12086.637400877988;12102.576409825613;12115.636530904087;12187.329696866758;9484.715458536255;9584.520773961134;9601.903980960102;9618.711438656852;10048.246381521269;9405.247580193705;9667.419954802734;9735.951320243637;9847.556859941464;9943.950280248553 06:11:11 INFO - PROCESS | 2957 | __end_tp_report 06:11:11 INFO - PROCESS | 2957 | __start_cc_report 06:11:11 INFO - PROCESS | 2957 | _x_x_mozilla_cycle_collect,428 06:11:11 INFO - PROCESS | 2957 | __end_cc_report 06:11:11 INFO - PROCESS | 2957 | __startTimestamp1470661871710__endTimestamp 06:11:11 INFO - PROCESS | 2957 | 06:11:11 INFO - PROCESS | 2957 | ------- Summary: start ------- 06:11:11 INFO - PROCESS | 2957 | Number of tests: 6 06:11:11 INFO - PROCESS | 2957 | 06:11:11 INFO - PROCESS | 2957 | [#0] dojo.html Cycles:165 Average:5885.63 Median:6139.17 stddev:654.59 (10.7%) stddev-sans-first:627.33 06:11:11 INFO - PROCESS | 2957 | Values: 3418.5 3443.2 3455.9 3460.7 3490.6 5806.9 5892.9 5930.5 5989.2 5989.3 5897.6 5913.2 5925.7 5980.5 6046.5 5253.2 5356.3 5397.7 5398.3 5399.1 5187.4 5295.0 5417.9 5428.6 5442.2 5321.6 5370.6 5382.3 5397.1 5428.9 5371.8 5382.4 5384.4 5399.5 5401.4 4304.9 5224.6 5228.8 5294.7 5388.3 5703.7 5850.2 5975.2 6010.6 6055.8 6243.4 6244.8 6291.3 6298.5 6313.0 6118.3 6248.3 6263.4 6359.6 6364.7 5639.2 6087.4 6101.1 6126.8 6143.7 6453.6 6489.8 6490.3 6503.5 6566.1 6113.1 6205.7 6240.6 6312.6 6338.8 5359.9 6249.0 6301.7 6373.8 6377.4 6261.1 6277.4 6288.7 6296.0 6327.5 6145.6 6232.3 6298.5 6308.9 6324.4 5002.2 5057.0 5059.6 5096.5 5104.1 4513.5 4524.1 4539.9 4577.0 4600.2 5949.4 6023.7 6066.2 6099.9 6109.3 6262.3 6388.7 6401.5 6407.6 6433.5 6077.9 6085.4 6133.8 6139.2 6150.1 5420.5 5532.8 5596.2 5597.8 5673.1 6424.4 6519.4 6521.9 6539.9 6545.2 6391.8 6396.1 6397.4 6425.3 6472.5 6304.4 6399.3 6534.3 6541.0 6548.2 6192.6 6242.9 6295.5 6316.4 6330.3 5107.6 6131.7 6351.4 6369.3 6373.4 6119.8 6172.5 6255.2 6266.6 6288.8 6184.6 6225.0 6253.2 6254.0 6254.3 5953.2 6166.1 6168.8 6203.4 6222.9 6129.0 6158.2 6267.0 6270.6 6274.1 6096.1 6135.2 6145.2 6148.0 6148.7 06:11:11 INFO - PROCESS | 2957 | 06:11:11 INFO - PROCESS | 2957 | [#1] ext.html Cycles:180 Average:74165.50 Median:39814.90 stddev:168458.95 (423.1%) stddev-sans-first:168840.61 06:11:11 INFO - PROCESS | 2957 | Values: 455.2 474.6 511.8 533.6 556.6 35081.3 35286.0 40003.8 40197.8 40248.8 41089.4 41158.8 41599.4 41641.0 41691.4 9577.4 9742.3 9754.7 9789.9 9802.2 8750.4 9490.3 9739.1 9817.3 9842.2 9831.8 9837.2 9875.8 9881.5 9885.1 9777.3 9813.0 9819.2 9823.8 9856.8 9621.7 9708.9 9711.2 9720.7 9723.2 39146.8 39542.6 39563.0 39618.0 39626.0 3085.6 3496.2 3620.3 3957.6 4286.5 31017.0 31559.2 31681.0 31835.9 31951.0 3138.6 3219.7 3344.3 3366.8 3376.5 421231.0 504272.0 517591.0 518939.4 519558.0 48925.0 58325.4 58607.7 58690.0 58770.1 48754.0 58988.0 59508.7 59556.4 59561.0 16002.8 16111.0 16200.0 16214.8 16233.8 12166.8 12622.7 12654.9 12664.7 12699.3 14536.7 15848.6 15921.8 15973.8 15981.1 7150.9 7169.7 7260.6 7304.7 7340.6 868.7 900.0 1012.0 1075.2 1080.5 26474.6 28930.4 29952.4 30342.0 30530.4 1021.8 1057.0 1139.6 1174.8 1184.8 15517.7 15599.0 15691.9 15883.7 16028.4 718992.0 725957.0 726936.0 727841.4 727952.0 58884.7 59139.0 59604.0 59780.0 59836.1 1349.9 1366.2 1380.5 1383.2 1386.9 28000.0 29086.0 29590.7 29970.0 30147.9 49827.3 50532.5 50590.7 50619.7 50949.5 635591.0 639528.0 640600.0 640847.0 641166.0 26235.2 26417.6 26662.5 27033.0 27039.8 46798.5 47455.0 47494.8 48461.3 48880.3 37789.4 38630.4 38859.4 39549.8 41039.4 29430.3 39092.6 39572.2 40373.4 40726.8 37244.6 37389.1 38138.8 38261.8 38527.8 33524.0 34437.5 34698.7 35706.8 35949.4 23413.9 23427.0 23699.3 23835.9 26202.0 06:11:11 INFO - PROCESS | 2957 | 06:11:11 INFO - PROCESS | 2957 | [#2] jquery.html Cycles:180 Average:34693.88 Median:13765.06 stddev:96463.84 (700.8%) stddev-sans-first:96699.86 06:11:11 INFO - PROCESS | 2957 | Values: 290.8 348.2 370.8 391.1 394.5 19865.2 19891.4 21005.5 21320.4 21350.3 11464.4 11920.0 20227.9 21285.5 21311.5 5416.5 5487.1 5586.0 5617.0 5634.7 5359.6 5423.9 5440.3 5498.6 5515.6 5485.1 5508.4 5518.3 5520.6 5524.9 5291.5 5386.9 6018.6 6034.6 6043.0 5275.7 5323.9 5332.4 5335.8 5351.2 13491.0 13616.1 21284.9 24949.3 26210.2 2365.5 2391.4 2425.6 2580.9 2867.2 10112.9 10334.8 12089.5 12800.9 15221.9 1755.8 1826.5 1867.7 1885.5 1902.6 107944.5 119762.4 126357.0 127667.0 128275.0 11311.4 11336.8 11670.6 11722.0 11956.6 14812.7 14817.8 14823.1 14828.0 14868.2 7810.0 7981.9 8293.0 8604.3 8726.7 8469.5 8477.2 8540.2 8558.9 8640.2 4082.3 4156.8 4363.8 4487.0 4521.5 1882.7 1928.3 1938.7 1956.0 1959.0 817.8 866.5 970.7 1001.1 1044.8 21324.3 21751.6 21813.0 21837.1 21886.2 871.0 902.3 964.3 986.4 1020.7 8210.8 9176.2 9695.5 10945.5 11208.3 564291.0 568195.2 570663.0 582837.0 583849.0 115659.4 130254.0 134969.3 146844.0 149226.0 831.6 975.3 1028.5 1044.6 1056.8 19185.9 19945.7 19966.5 20173.5 20443.4 53501.5 56485.9 56990.7 57106.7 57767.0 75232.0 79364.0 79850.0 83112.6 87337.0 7935.0 8106.2 8113.0 8466.6 8560.2 8681.6 12409.7 13224.8 13661.7 13883.3 11508.3 11684.4 11839.6 11905.3 12001.6 9310.9 9705.9 11061.7 11179.3 11831.3 11335.7 11701.5 11876.0 11981.4 12043.1 6837.6 6891.5 8456.5 8483.6 8602.0 9902.4 11546.9 11795.9 11979.2 12034.7 06:11:11 INFO - PROCESS | 2957 | 06:11:11 INFO - PROCESS | 2957 | [#3] mootools.html Cycles:180 Average:5679.95 Median:4803.32 stddev:3214.02 (66.9%) stddev-sans-first:3207.46 06:11:11 INFO - PROCESS | 2957 | Values: 1468.6 1527.3 1724.7 1836.7 1846.6 7838.3 8300.9 8431.4 8886.4 8889.8 8578.2 8795.5 8798.6 8823.7 8843.8 2343.8 2380.6 2381.7 2388.4 2396.0 2095.4 2327.5 2331.7 2365.0 2386.9 2337.6 2338.0 2347.2 2352.6 2359.8 2316.7 2320.5 2333.8 2345.8 2348.0 2330.3 2330.9 2335.9 2340.2 2340.4 8660.6 8831.4 8870.0 8883.4 8896.2 5159.6 5189.1 5304.4 5323.3 5328.6 3479.4 3554.1 3620.5 3625.7 3643.1 1043.5 1071.5 1090.3 1105.5 1108.4 10472.5 11008.3 11587.0 11630.4 11753.8 4522.6 4703.8 4800.1 4806.5 4829.8 9877.9 9946.0 9951.5 9959.1 9983.5 5322.4 5342.7 5349.0 5356.7 5362.5 3810.0 4695.2 4862.9 4884.3 4892.5 3917.9 3955.3 4002.5 4029.7 4065.3 1286.7 1288.6 1294.4 1296.0 1296.6 804.7 810.6 884.6 888.2 925.4 5835.3 5871.9 6088.1 6128.4 6274.6 432.3 437.4 441.5 446.1 452.8 3690.8 3974.5 3999.0 4070.8 4132.9 10451.0 10827.1 10858.3 10877.6 10882.8 10794.7 10808.7 10808.8 10818.7 10886.2 7117.0 8203.2 8302.4 8331.1 8337.0 5019.6 5223.4 5366.2 5765.9 6068.6 8459.6 10028.4 10099.2 10140.3 10145.5 9836.9 10298.8 10307.9 10324.0 10349.6 6920.6 7285.9 7414.2 7572.2 7644.8 8445.5 8506.5 8519.1 8535.7 8546.6 7319.6 7440.5 7558.4 7584.0 7711.9 7210.6 7221.2 7333.2 7340.7 7466.9 6974.8 6984.3 7028.1 7066.5 7074.9 4885.1 4961.7 5045.6 5103.2 5133.6 4193.5 4504.6 4690.4 4836.6 5004.0 06:11:11 INFO - PROCESS | 2957 | 06:11:11 INFO - PROCESS | 2957 | [#4] prototype.html Cycles:180 Average:4503.37 Median:4879.24 stddev:1384.26 (28.4%) stddev-sans-first:1351.11 06:11:11 INFO - PROCESS | 2957 | Values: 265.9 298.4 304.5 314.2 314.6 4230.9 4404.5 5454.9 5729.7 5749.6 4646.9 5210.6 5627.2 5642.4 5648.0 4329.0 4330.7 4348.3 4350.5 4369.4 3479.4 3770.8 3871.0 3981.8 4228.2 4186.1 4199.5 4205.2 4206.8 4211.5 3528.7 3850.4 4214.4 4224.2 4261.9 3648.7 3649.7 3650.4 3666.2 3667.3 5390.2 5486.7 5494.5 5507.2 5528.4 4190.7 4719.5 4829.3 4855.2 4905.4 5129.5 5625.8 5717.7 5996.6 6021.3 3918.3 3934.0 3934.7 3960.5 3961.1 5477.7 5994.3 6179.3 6222.9 6289.2 4045.2 4047.8 4060.2 4066.1 4081.4 3766.9 3978.4 4044.6 4048.5 4069.8 4754.7 4802.6 4827.6 4834.5 4840.4 4914.6 5969.0 6072.7 6079.8 6086.8 1317.4 1341.4 1342.2 1389.2 1409.4 722.1 819.3 834.6 845.6 852.7 4012.2 4160.6 4428.5 4614.4 4710.9 4435.7 5105.3 5151.6 5180.3 5193.4 4185.8 4397.0 4688.6 4725.7 4752.5 2167.8 2402.7 2652.0 2684.0 2743.0 5315.7 5326.9 5342.0 5344.8 5375.6 4720.4 4785.6 5281.0 5286.5 5289.2 4793.0 4821.5 4897.0 5356.9 5433.4 5077.9 5134.3 5232.7 5256.4 5287.2 3790.5 4524.8 4910.3 4941.1 5199.9 4629.6 4923.4 5211.7 5259.2 5341.8 3555.4 3570.4 3817.3 3939.4 4031.6 5334.5 6048.2 6079.3 6147.5 6164.2 4861.5 5200.0 5956.0 5982.1 6035.3 5386.1 5535.1 5704.1 5968.8 5979.2 5061.4 5137.6 5145.7 5850.3 5855.5 5215.6 5249.0 5466.5 5516.3 5855.5 5364.3 5787.9 5810.6 5840.3 5864.6 06:11:11 INFO - PROCESS | 2957 | 06:11:11 INFO - PROCESS | 2957 | [#5] yui.html Cycles:180 Average:25907.08 Median:4051.09 stddev:42407.83 (1046.8%) stddev-sans-first:42484.37 06:11:11 INFO - PROCESS | 2957 | Values: 643.4 766.1 787.8 794.8 816.8 15580.6 15793.4 15816.7 15980.5 16025.3 14342.9 14458.1 14470.8 14475.6 14483.0 674.7 833.9 835.0 864.6 873.8 740.4 858.2 873.4 875.6 875.8 904.5 928.2 931.1 931.7 933.2 890.4 902.6 912.6 923.0 926.7 668.3 685.6 688.4 688.5 691.4 14735.9 14767.2 14783.6 14811.8 14846.8 14557.7 14597.1 14686.9 14693.6 14707.6 10647.6 11841.0 12137.0 12137.5 12542.9 3824.6 3838.5 4030.2 4071.9 4076.4 116333.0 116582.5 118599.0 119380.0 119967.4 10907.5 11071.9 11250.5 11676.4 11745.9 19589.4 22949.5 22967.8 23211.0 23440.5 7980.1 8080.8 8133.1 8229.0 8305.4 4473.4 4486.5 4505.6 4525.9 4688.8 3549.3 3647.4 3663.4 3664.9 3668.9 639.3 642.7 654.1 672.6 672.8 583.9 592.3 597.6 654.9 658.0 8670.2 8938.3 9553.0 9611.3 9770.0 568.3 626.0 628.0 680.6 715.7 4441.4 4580.6 4863.9 4878.0 4899.4 96258.5 122707.0 159274.0 159283.0 162641.0 137017.0 138891.6 141019.0 147821.0 148222.0 124101.0 124952.0 127283.0 127859.0 129964.0 8063.3 8473.4 8693.3 8943.0 9284.7 65642.0 65813.0 66326.0 67087.3 67378.0 90829.0 98923.5 103253.3 108929.9 108992.0 12019.4 12027.1 12222.9 12559.9 12751.8 12649.9 12984.3 12985.2 13024.7 13131.4 12254.8 12274.3 12302.6 12309.3 12564.4 12317.9 12424.5 12449.8 12510.7 12593.5 10009.8 12086.6 12102.6 12115.6 12187.3 9484.7 9584.5 9601.9 9618.7 10048.2 9405.2 9667.4 9736.0 9847.6 9944.0 06:11:11 INFO - PROCESS | 2957 | -------- Summary: end -------- 06:11:11 INFO - PROCESS | 2957 | 06:11:12 INFO - TEST-INFO | 2957: exit 0 06:11:12 INFO - TEST-OK | dromaeo_css | took 1114279ms 06:11:12 INFO - TEST-START | kraken 06:11:12 INFO - operating with platform_type : mac_ 06:11:12 INFO - Initialising browser for kraken test... 06:11:12 INFO - TEST-INFO | started process 2961 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmp7YyV5v/profile http://localhost:49765/getInfo.html) 06:11:15 INFO - PROCESS | 2961 | __metrics Screen width/height:1600/1200 06:11:15 INFO - PROCESS | 2961 | colorDepth:24 06:11:15 INFO - PROCESS | 2961 | Browser inner width/height: 1024/689 06:11:15 INFO - PROCESS | 2961 | __metrics 06:11:15 ERROR - PROCESS | 2961 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 06:11:16 INFO - TEST-INFO | 2961: exit 0 06:11:16 INFO - Browser initialized. 06:11:16 INFO - Running cycle 1/1 for kraken test... 06:11:16 INFO - TEST-INFO | started process 2963 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmp7YyV5v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:11:28 INFO - PROCESS | 2963 | RSS: Main: 254922752 06:11:28 INFO - PROCESS | 2963 | 06:11:30 INFO - PROCESS | 2963 | Cycle 1(1): loaded http://localhost:49765/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49765/tests/kraken/driver.html?testName=audio-beat-detection) 06:11:31 INFO - PROCESS | 2963 | RSS: Main: 267841536 06:11:31 INFO - PROCESS | 2963 | 06:11:34 INFO - PROCESS | 2963 | Cycle 1(1): loaded http://localhost:49765/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49765/tests/kraken/driver.html?testName=audio-dft) 06:11:34 INFO - PROCESS | 2963 | RSS: Main: 276533248 06:11:34 INFO - PROCESS | 2963 | 06:11:38 INFO - PROCESS | 2963 | Cycle 1(1): loaded http://localhost:49765/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49765/tests/kraken/driver.html?testName=audio-fft) 06:11:39 INFO - PROCESS | 2963 | RSS: Main: 278851584 06:11:39 INFO - PROCESS | 2963 | 06:11:41 INFO - PROCESS | 2963 | Cycle 1(1): loaded http://localhost:49765/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49765/tests/kraken/driver.html?testName=audio-oscillator) 06:11:41 INFO - PROCESS | 2963 | RSS: Main: 281288704 06:11:41 INFO - PROCESS | 2963 | 06:11:43 INFO - PROCESS | 2963 | Cycle 1(1): loaded http://localhost:49765/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49765/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:11:44 INFO - PROCESS | 2963 | RSS: Main: 282083328 06:11:44 INFO - PROCESS | 2963 | 06:11:47 INFO - PROCESS | 2963 | Cycle 1(1): loaded http://localhost:49765/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49765/tests/kraken/driver.html?testName=imaging-darkroom) 06:11:47 INFO - PROCESS | 2963 | RSS: Main: 282292224 06:11:47 INFO - PROCESS | 2963 | 06:11:50 INFO - PROCESS | 2963 | Cycle 1(1): loaded http://localhost:49765/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49765/tests/kraken/driver.html?testName=imaging-desaturate) 06:11:51 INFO - PROCESS | 2963 | RSS: Main: 282165248 06:11:51 INFO - PROCESS | 2963 | 06:11:54 INFO - PROCESS | 2963 | Cycle 1(1): loaded http://localhost:49765/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49765/tests/kraken/driver.html?testName=json-parse-financial) 06:11:55 INFO - PROCESS | 2963 | RSS: Main: 282808320 06:11:55 INFO - PROCESS | 2963 | 06:11:56 INFO - PROCESS | 2963 | Cycle 1(1): loaded http://localhost:49765/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49765/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:11:57 INFO - PROCESS | 2963 | RSS: Main: 282435584 06:11:57 INFO - PROCESS | 2963 | 06:11:59 INFO - PROCESS | 2963 | Cycle 1(1): loaded http://localhost:49765/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49765/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:11:59 INFO - PROCESS | 2963 | RSS: Main: 282382336 06:11:59 INFO - PROCESS | 2963 | 06:12:02 INFO - PROCESS | 2963 | Cycle 1(1): loaded http://localhost:49765/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49765/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:12:02 INFO - PROCESS | 2963 | RSS: Main: 282722304 06:12:02 INFO - PROCESS | 2963 | 06:12:05 INFO - PROCESS | 2963 | Cycle 1(1): loaded http://localhost:49765/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49765/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:12:06 INFO - PROCESS | 2963 | RSS: Main: 282435584 06:12:06 INFO - PROCESS | 2963 | 06:12:09 INFO - PROCESS | 2963 | Cycle 1(1): loaded http://localhost:49765/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49765/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:12:10 INFO - PROCESS | 2963 | RSS: Main: 282984448 06:12:10 INFO - PROCESS | 2963 | 06:12:11 INFO - PROCESS | 2963 | Cycle 1(1): loaded http://localhost:49765/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49765/tests/kraken/driver.html?testName=ai-astar) 06:12:12 INFO - PROCESS | 2963 | RSS: Main: 284049408 06:12:12 INFO - PROCESS | 2963 | 06:12:12 INFO - PROCESS | 2963 | __start_tp_report 06:12:12 INFO - PROCESS | 2963 | _x_x_mozilla_page_load 06:12:12 INFO - PROCESS | 2963 | _x_x_mozilla_page_load_details 06:12:12 INFO - PROCESS | 2963 | |i|pagename|runs| 06:12:12 INFO - PROCESS | 2963 | |0;ai-astar;103;115;105;116;118;116;114;116;116;96 06:12:12 INFO - PROCESS | 2963 | |1;audio-beat-detection;145;109;132;166;112;136;133;112;160;111 06:12:12 INFO - PROCESS | 2963 | |2;audio-dft;201;207;211;258;234;279;271;201;239;219 06:12:12 INFO - PROCESS | 2963 | |3;audio-fft;76;83;79;155;59;59;61;66;141;60 06:12:12 INFO - PROCESS | 2963 | |4;audio-oscillator;68;72;121;73;72;76;118;71;82;153 06:12:12 INFO - PROCESS | 2963 | |5;imaging-gaussian-blur;88;87;89;87;90;86;89;86;89;85 06:12:12 INFO - PROCESS | 2963 | |6;imaging-darkroom;94;105;96;96;96;95;96;96;130;114 06:12:12 INFO - PROCESS | 2963 | |7;imaging-desaturate;90;91;91;94;95;91;89;96;148;150 06:12:12 INFO - PROCESS | 2963 | |8;json-parse-financial;56;59;55;57;74;59;59;57;52;49 06:12:12 INFO - PROCESS | 2963 | |9;json-stringify-tinderbox;70;80;69;77;75;107;110;109;72;71 06:12:12 INFO - PROCESS | 2963 | |10;stanford-crypto-aes;91;93;84;79;105;101;109;87;88;85 06:12:12 INFO - PROCESS | 2963 | |11;stanford-crypto-ccm;141;161;138;134;139;140;141;148;134;157 06:12:12 INFO - PROCESS | 2963 | |12;stanford-crypto-pbkdf2;222;183;166;171;168;167;167;169;166;165 06:12:12 INFO - PROCESS | 2963 | |13;stanford-crypto-sha256-iterative;72;79;87;86;87;89;89;72;83;92 06:12:12 INFO - PROCESS | 2963 | __end_tp_report 06:12:12 INFO - PROCESS | 2963 | __start_cc_report 06:12:12 INFO - PROCESS | 2963 | _x_x_mozilla_cycle_collect,1052 06:12:12 INFO - PROCESS | 2963 | __end_cc_report 06:12:12 INFO - PROCESS | 2963 | __startTimestamp1470661932167__endTimestamp 06:12:12 INFO - PROCESS | 2963 | 06:12:12 INFO - PROCESS | 2963 | ------- Summary: start ------- 06:12:12 INFO - PROCESS | 2963 | Number of tests: 14 06:12:12 INFO - PROCESS | 2963 | 06:12:12 INFO - PROCESS | 2963 | [#0] ai-astar Cycles:10 Average:111.50 Median:116.00 stddev:7.43 (6.4%) stddev-sans-first:7.21 06:12:12 INFO - PROCESS | 2963 | Values: 103.0 115.0 105.0 116.0 118.0 116.0 114.0 116.0 116.0 96.0 06:12:12 INFO - PROCESS | 2963 | 06:12:12 INFO - PROCESS | 2963 | [#1] audio-beat-detection Cycles:10 Average:131.60 Median:134.50 stddev:20.80 (15.5%) stddev-sans-first:21.49 06:12:12 INFO - PROCESS | 2963 | Values: 145.0 109.0 132.0 166.0 112.0 136.0 133.0 112.0 160.0 111.0 06:12:12 INFO - PROCESS | 2963 | 06:12:12 INFO - PROCESS | 2963 | [#2] audio-dft Cycles:10 Average:232.00 Median:236.50 stddev:29.09 (12.3%) stddev-sans-first:28.61 06:12:12 INFO - PROCESS | 2963 | Values: 201.0 207.0 211.0 258.0 234.0 279.0 271.0 201.0 239.0 219.0 06:12:12 INFO - PROCESS | 2963 | 06:12:12 INFO - PROCESS | 2963 | [#3] audio-fft Cycles:10 Average:83.90 Median:63.50 stddev:35.05 (55.2%) stddev-sans-first:37.06 06:12:12 INFO - PROCESS | 2963 | Values: 76.0 83.0 79.0 155.0 59.0 59.0 61.0 66.0 141.0 60.0 06:12:12 INFO - PROCESS | 2963 | 06:12:12 INFO - PROCESS | 2963 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:72.00 stddev:29.35 (40.8%) stddev-sans-first:29.97 06:12:12 INFO - PROCESS | 2963 | Values: 68.0 72.0 121.0 73.0 72.0 76.0 118.0 71.0 82.0 153.0 06:12:12 INFO - PROCESS | 2963 | 06:12:12 INFO - PROCESS | 2963 | [#5] imaging-gaussian-blur Cycles:10 Average:87.60 Median:88.50 stddev:1.65 (1.9%) stddev-sans-first:1.74 06:12:12 INFO - PROCESS | 2963 | Values: 88.0 87.0 89.0 87.0 90.0 86.0 89.0 86.0 89.0 85.0 06:12:12 INFO - PROCESS | 2963 | 06:12:12 INFO - PROCESS | 2963 | [#6] imaging-darkroom Cycles:10 Average:101.80 Median:96.00 stddev:11.69 (12.2%) stddev-sans-first:12.05 06:12:12 INFO - PROCESS | 2963 | Values: 94.0 105.0 96.0 96.0 96.0 95.0 96.0 96.0 130.0 114.0 06:12:12 INFO - PROCESS | 2963 | 06:12:12 INFO - PROCESS | 2963 | [#7] imaging-desaturate Cycles:10 Average:103.50 Median:91.00 stddev:24.09 (26.5%) stddev-sans-first:25.05 06:12:12 INFO - PROCESS | 2963 | Values: 90.0 91.0 91.0 94.0 95.0 91.0 89.0 96.0 148.0 150.0 06:12:12 INFO - PROCESS | 2963 | 06:12:12 INFO - PROCESS | 2963 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:58.00 stddev:6.58 (11.4%) stddev-sans-first:6.95 06:12:12 INFO - PROCESS | 2963 | Values: 56.0 59.0 55.0 57.0 74.0 59.0 59.0 57.0 52.0 49.0 06:12:12 INFO - PROCESS | 2963 | 06:12:12 INFO - PROCESS | 2963 | [#9] json-stringify-tinderbox Cycles:10 Average:84.00 Median:71.50 stddev:17.35 (24.3%) stddev-sans-first:17.65 06:12:12 INFO - PROCESS | 2963 | Values: 70.0 80.0 69.0 77.0 75.0 107.0 110.0 109.0 72.0 71.0 06:12:12 INFO - PROCESS | 2963 | 06:12:12 INFO - PROCESS | 2963 | [#10] stanford-crypto-aes Cycles:10 Average:92.20 Median:86.00 stddev:9.80 (11.4%) stddev-sans-first:10.38 06:12:12 INFO - PROCESS | 2963 | Values: 91.0 93.0 84.0 79.0 105.0 101.0 109.0 87.0 88.0 85.0 06:12:12 INFO - PROCESS | 2963 | 06:12:12 INFO - PROCESS | 2963 | [#11] stanford-crypto-ccm Cycles:10 Average:143.30 Median:141.00 stddev:9.21 (6.5%) stddev-sans-first:9.74 06:12:12 INFO - PROCESS | 2963 | Values: 141.0 161.0 138.0 134.0 139.0 140.0 141.0 148.0 134.0 157.0 06:12:12 INFO - PROCESS | 2963 | 06:12:12 INFO - PROCESS | 2963 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.40 Median:168.50 stddev:17.51 (10.4%) stddev-sans-first:5.51 06:12:12 INFO - PROCESS | 2963 | Values: 222.0 183.0 166.0 171.0 168.0 167.0 167.0 169.0 166.0 165.0 06:12:12 INFO - PROCESS | 2963 | 06:12:12 INFO - PROCESS | 2963 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:83.60 Median:87.00 stddev:7.06 (8.1%) stddev-sans-first:6.11 06:12:12 INFO - PROCESS | 2963 | Values: 72.0 79.0 87.0 86.0 87.0 89.0 89.0 72.0 83.0 92.0 06:12:12 INFO - PROCESS | 2963 | -------- Summary: end -------- 06:12:12 INFO - PROCESS | 2963 | 06:12:13 INFO - TEST-INFO | 2963: exit 0 06:12:13 INFO - TEST-OK | kraken | took 60834ms 06:12:13 INFO - SUITE-END | took 1175s 06:12:13 INFO - Completed test suite (00:19:35) 06:12:13 INFO - javascript benchmark 06:12:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7350.858993822416, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3418.52140700302, 3443.190850150215, 3455.8790442334525, 3460.7058400035994, 3490.598581163167, 5806.854828629286, 5892.941070589292, 5930.52555795537, 5989.221401217841, 5989.251343582052, 5897.557683173768, 5913.2017177681, 5925.73334199962, 5980.491658209057, 6046.54650901182, 5253.159494480884, 5356.276902618155, 5397.7031263280505, 5398.2982212312545, 5399.136138217886, 5187.3775146982225, 5295.0468915595175, 5417.864553386157, 5428.565714742811, 5442.156465747816, 5321.627486075976, 5370.570354371641, 5382.300300960889, 5397.082495975694, 5428.864278393033, 5371.811986580451, 5382.381026181961, 5384.434634363374, 5399.487048730364, 5401.351837779453, 4304.870853874389, 5224.63427560071, 5228.79084836606, 5294.708791016493, 5388.326459192601, 5703.74333155009, 5850.151727999416, 5975.19334889793, 6010.57925945184, 6055.757769689207, 6243.355754041179, 6244.781432649836, 6291.276503202099, 6298.527610429236, 6313.0, 6118.3146263159115, 6248.31268560458, 6263.43629073381, 6359.55483116182, 6364.681765911732, 5639.154126881001, 6087.391260873966, 6101.145839582462, 6126.8230438726505, 6143.723532441051, 6453.645049522227, 6489.772857949949, 6490.286068532458, 6503.479721622353, 6566.1135746674545, 6113.050656958994, 6205.689715514206, 6240.563160578716, 6312.621242725451, 6338.809835704937, 5359.892802143935, 6248.968755156286, 6301.7164227609865, 6373.808785736435, 6377.394147555975, 6261.092141639437, 6277.403646653652, 6288.654124023223, 6296.024116261987, 6327.462165715873, 6145.586515101551, 6232.345603711636, 6298.527610429144, 6308.905366419507, 6324.367563243731, 5002.2496625506465, 5056.974715126401, 5059.620528460307, 5096.464871188546, 5104.1067813133295, 4513.54864513546, 4524.09518096382, 4539.931901021488, 4577.0159415725775, 4600.217962946307, 5949.434803693643, 6023.728932197974, 6066.241719785027, 6099.908501372394, 6109.297430795426, 6262.3111457739615, 6388.744450222032, 6401.519886008475, 6407.583507072119, 6433.485321174388, 6077.878442431127, 6085.36103709113, 6133.84665383369, 6139.171211886338, 6150.138980542728, 5420.4850539198715, 5532.7786888524815, 5596.188552659842, 5597.832065038056, 5673.149027645886, 6424.421802037839, 6519.380658837403, 6521.8695626088165, 6539.934600654123, 6545.214574251025, 6391.808245752635, 6396.072569477493, 6397.392247736458, 6425.293217746138, 6472.546921715435, 6304.369563043842, 6399.264084630141, 6534.313897040743, 6541.0, 6548.246951600627, 6192.59748116371, 6242.937570624417, 6295.464885484602, 6316.368363163647, 6330.272018717907, 5107.642465027561, 6131.693415329127, 6351.428371446592, 6369.299377068612, 6373.362663733589, 6119.807225076679, 6172.475339596184, 6255.218097737783, 6266.561340706289, 6288.779892703734, 6184.567080304336, 6225.00399936008, 6253.187085678833, 6253.96873015632, 6254.2807577129215, 5953.166556682155, 6166.075088736546, 6168.753249870135, 6203.4416902479, 6222.937770622236, 6129.049997250433, 6158.230221222348, 6267.0, 6270.623762574078, 6274.058891166179, 6096.055111457731, 6135.1717518136265, 6145.201123854049, 6147.9855823788575, 6148.739508400857], "value": 5844.279175350218, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [455.1579577781104, 474.5515487863968, 511.7927239468017, 533.5918022712623, 556.6103727390824, 35081.29837403251, 35286.0, 40003.79998100009, 40197.79901100498, 40248.79253622396, 41089.38365924513, 41158.794206029, 41599.37600935988, 41641.0, 41691.37462938051, 9577.377470464415, 9742.318037737361, 9754.707358779247, 9789.90210097897, 9802.215822734164, 8750.431221970552, 9490.288228382864, 9739.123478886899, 9817.263705222102, 9842.212622990144, 9831.754206144831, 9837.163841073518, 9875.802483950316, 9881.456519891439, 9885.0609192127, 9777.315587908814, 9812.95093524535, 9819.214462842956, 9823.754406139833, 9856.802863942752, 9621.711348659552, 9708.854367184498, 9711.174550163245, 9720.708378748648, 9723.222142228604, 39146.804265978775, 39542.60457395418, 39563.0, 39618.0, 39626.009349766195, 3085.598872146629, 3496.230829217568, 3620.275944811022, 3957.6240257175523, 4286.485621725382, 31017.0, 31559.233017886294, 31681.049568512983, 31835.88574399885, 31951.0, 3138.6233651961684, 3219.6941290577356, 3344.2642618623863, 3366.848491817874, 3376.4766461198556, 421231.0, 504272.0, 517591.0, 518939.40530297486, 519558.0, 48925.0, 58325.416745832845, 58607.70696146492, 58690.0, 58770.11844822331, 48754.0, 58988.0, 59508.7024564883, 59556.40443595508, 59561.0, 16002.75995860063, 16111.0, 16200.0, 16214.75677864833, 16233.83766162347, 12166.756664866652, 12622.684432889251, 12654.87345126537, 12664.74670506603, 12699.301538415475, 14536.709265814625, 15848.60378490547, 15921.761173582405, 15973.840261597468, 15981.121038343003, 7150.923973335149, 7169.713211471482, 7260.564366138048, 7304.735531985101, 7340.559566426032, 868.6699054359303, 899.955002249898, 1011.9645812396531, 1075.2365820267698, 1080.524569189554, 26474.6028809568, 28930.421391572472, 29952.40095198084, 30342.0, 30530.38939221203, 1021.8467229915424, 1056.9641751083827, 1139.5954436175205, 1174.8296497007887, 1184.810430331143, 15517.689646207013, 15598.98606590568, 15691.921540392224, 15883.682326353408, 16028.358865645243, 718992.0, 725957.0, 726936.0, 727841.3607931926, 727952.0, 58884.705576471846, 59139.0, 59604.0, 59780.0, 59836.10245846316, 1349.9122557033959, 1366.1598117157876, 1380.4685196199534, 1383.156274672449, 1386.9098508596908, 28000.019999299926, 29086.0, 29590.704092959655, 29970.0, 30147.944821931127, 49827.25259121189, 50532.49467505278, 50590.711603745636, 50619.74690126526, 50949.49050509447, 635591.0, 639528.0, 640600.0, 640847.0, 641166.0, 26235.21294361172, 26417.60373594436, 26662.466750665266, 27033.0, 27039.783209755216, 46798.53201467942, 47455.0, 47494.76252618715, 48461.27308090311, 48880.26679599738, 37789.43315850209, 38630.42054369243, 38859.41710874395, 39549.80225098856, 41039.38440923329, 29430.264243394085, 39092.6090739089, 39572.2085558293, 40373.394399084624, 40726.79636601798, 37244.627553724116, 37389.06527336838, 38138.80930595329, 38261.808690956364, 38527.807360963016, 33524.0, 34437.48343774895, 34698.65301346954, 35706.821465892506, 35949.38227779704, 23413.882930585238, 23427.0, 23699.289021329387, 23835.880820595787, 26202.0], "value": 19990.392355969492, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.75721772320117, 348.24778478486473, 370.78679759138504, 391.0575513013636, 394.500956290293, 19865.20539178433, 19891.403257902268, 21005.47486312841, 21320.36038918835, 21350.252741154025, 11464.426778661074, 11920.046396288299, 20227.887466189353, 21285.467863303387, 21311.467213319676, 5416.485433883785, 5487.149491828773, 5585.972070139644, 5617.0, 5634.690092044936, 5359.598030147735, 5423.918641220365, 5440.265564148829, 5498.615096943216, 5515.641483303572, 5485.122380419134, 5508.394076651565, 5518.310211223597, 5520.641158324696, 5524.861878453051, 5291.4708529147165, 5386.946130538684, 6018.638881667114, 6034.63792172471, 6043.002904520748, 5275.736213189363, 5323.893522129574, 5332.373626044055, 5335.813246536352, 5351.2240725095035, 13491.0, 13616.114952528153, 21284.893575532024, 24949.251522454357, 26210.213693589223, 2365.47959448921, 2391.4021494626345, 2425.6240282756203, 2580.8709564521887, 2867.197184788242, 10112.938141495111, 10334.793304133875, 12089.516419343216, 12800.935995320056, 15221.934464587483, 1755.7893052833742, 1826.4520643806804, 1867.6544839204792, 1885.5474686075381, 1902.6384986852593, 107944.46027769889, 119762.4011879935, 126357.0, 127667.0, 128275.0, 11311.434428278717, 11336.829947550794, 11670.591529296435, 11722.0, 11956.641300760992, 14812.70374592502, 14817.77773333401, 14823.110613363233, 14828.036177648419, 14868.182249976355, 7810.0, 7981.922440470578, 8293.0, 8604.268637165911, 8726.65093396257, 8469.5341756204, 8477.194666506672, 8540.231379175904, 8558.871616925751, 8640.179182977607, 4082.265192265421, 4156.771377574262, 4363.825446982085, 4486.967997360625, 4521.525239849834, 1882.7364169016348, 1928.3443629166152, 1938.7285779990812, 1955.9706604400944, 1959.0, 817.7955511122219, 866.5104216117874, 970.6507953944024, 1001.0940099210227, 1044.7910417916446, 21324.253651122446, 21751.564968700855, 21813.0, 21837.126514939224, 21886.23398181056, 870.991290087091, 902.3367824648877, 964.3008818606594, 986.4278718343344, 1020.7142000239945, 8210.794730131674, 9176.17414432691, 9695.466749328714, 10945.4527273636, 11208.262719278526, 564291.0, 568195.1590242023, 570663.0, 582837.0, 583849.0, 115659.42170289264, 130254.0, 134969.32515337362, 146844.0, 149226.0, 831.6340810043562, 975.3221511049752, 1028.4960369418932, 1044.5769463367349, 1056.772793849326, 19185.90407047956, 19945.70567703876, 19966.52594239476, 20173.49566260855, 20443.38669839907, 53501.464985349645, 56485.8702825933, 56990.71504642616, 57106.7144664274, 57767.0, 75232.0, 79364.0, 79850.0, 83112.58443707743, 87337.0, 7935.0, 8106.189381061847, 8112.959435202786, 8466.619002145042, 8560.186782255676, 8681.609327580149, 12409.689757756129, 13224.801627975396, 13661.658458538615, 13883.305834708022, 11508.251963622337, 11684.357360345262, 11839.644810655349, 11905.345206013752, 12001.63995080149, 9310.906890931004, 9705.854412183682, 11061.668149955514, 11179.329240245612, 11831.290122592673, 11335.659930202108, 11701.473433695674, 11876.0, 11981.400929953641, 12043.09676774228, 6837.62393068386, 6891.483138764513, 8456.492610443393, 8483.618237179466, 8602.0, 9902.405855648683, 11546.884531154581, 11795.941020295188, 11979.221350612183, 12034.699132521757], "value": 9512.556784371345, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1468.5520916120581, 1527.274544591319, 1724.6550689862022, 1836.6602178596952, 1846.6306738652272, 7838.333741631968, 8300.875486867695, 8431.40980131391, 8886.422382545146, 8889.777755556106, 8578.22795948366, 8795.516246606434, 8798.604062817172, 8823.735287941356, 8843.806086178363, 2343.8359314847967, 2380.6429035644705, 2381.654660074288, 2388.4267775733874, 2395.993682653281, 2095.3504413631745, 2327.5461285049423, 2331.6502524621274, 2365.0, 2386.940326491834, 2337.649352597107, 2337.9766202338014, 2347.225415612852, 2352.6000579901374, 2359.7758212969825, 2316.6756654068445, 2320.4662927526597, 2333.8249631277636, 2345.812335013195, 2348.002099107881, 2330.265966220652, 2330.9184178553837, 2335.94160145996, 2340.157543284416, 2340.4265954841003, 8660.566971651393, 8831.381803273773, 8870.024297327289, 8883.42257753244, 8896.19934205918, 5159.587233021387, 5189.143791274435, 5304.443033481468, 5323.281357016831, 5328.573714102862, 3479.373712731707, 3554.0759402555523, 3620.5112309838096, 3625.7099432045375, 3643.0892276930767, 1043.546057465005, 1071.50175168547, 1090.2967585907045, 1105.4748994227677, 1108.384846410242, 10472.476376181237, 11008.339499630049, 11587.015103716194, 11630.418479076012, 11753.764924701543, 4522.5929666330185, 4703.835365762182, 4800.135975524369, 4806.49531799163, 4829.830955916596, 9877.851832222523, 9946.00539946014, 9951.502424878727, 9959.103680668775, 9983.500824958723, 5322.4411436799355, 5342.679439233659, 5348.9732551337775, 5356.651817631841, 5362.51737343641, 3810.047488127968, 4695.201815691341, 4862.927056094161, 4884.267359896044, 4892.535209155125, 3917.9020524486546, 3955.2880481513603, 4002.45966794479, 4029.738067025634, 4065.329220678614, 1286.7490839286436, 1288.5683296095726, 1294.4239813283186, 1295.9676008099873, 1296.598054603076, 804.7022601637432, 810.631162820915, 884.5754038061766, 888.2228050455851, 925.4169872980115, 5835.299764028344, 5871.853203669943, 6088.056351265561, 6128.3565225651555, 6274.560780745304, 432.2629915993224, 437.4422611170719, 441.5341814385854, 446.08329882092613, 452.8279253883503, 3690.797006164633, 3974.463447434617, 3999.0, 4070.7964601769795, 4132.896677583084, 10451.0, 10827.079698225582, 10858.34849909008, 10877.619283325046, 10882.836757448644, 10794.676159715222, 10808.675739727822, 10808.78382432347, 10818.729531761612, 10886.183536234814, 7116.964415177891, 8203.220694034057, 8302.418830681914, 8331.12523185069, 8336.958315208385, 5019.62352823547, 5223.373195216598, 5366.248725178556, 5765.884682306247, 6068.575199736153, 8459.619317130868, 10028.448435336126, 10099.242556808416, 10140.340877842917, 10145.49272536385, 9836.901630983599, 10298.845517317097, 10307.94846025765, 10324.0, 10349.63776267827, 6920.5847649141215, 7285.890711639436, 7414.22150674193, 7572.20491848348, 7644.847103058019, 8445.493270403795, 8506.489610623383, 8519.062903080532, 8535.701250456204, 8546.572671366532, 7319.560826350223, 7440.516366436164, 7558.433117516099, 7584.0, 7711.922880771345, 7210.639468026683, 7221.241769614325, 7333.230010848997, 7340.743073992385, 7466.925330746841, 6974.79075627732, 6984.301569842975, 7028.121484814398, 7066.4700147490175, 7074.858502829811, 4885.145099607484, 4961.7271050092595, 5045.62157838171, 5103.209002604603, 5133.614978876674, 4193.517745459311, 4504.572065653758, 4690.413698287714, 4836.564709176191, 5004.049230646166], "value": 4483.368873868021, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [265.8657378024098, 298.3674609827165, 304.53406288378784, 314.1956591126716, 314.5517637366752, 4230.873073807791, 4404.537523560024, 5454.91817622736, 5729.713514324283, 5749.5687823413255, 4646.907061858761, 5210.583153347732, 5627.184058311543, 5642.4357564243655, 5647.971760141194, 4329.047609525907, 4330.675199360045, 4348.326009468537, 4350.456192975878, 4369.388285639997, 3479.425894727367, 3770.8491660333552, 3870.9548421926065, 3981.805458362494, 4228.175505776375, 4186.079062606222, 4199.517055538621, 4205.222033923718, 4206.768627725474, 4211.504915754909, 3528.6824185823143, 3850.4224366345134, 4214.3889136075095, 4224.218519573888, 4261.87214383569, 3648.689861361761, 3649.7262705297208, 3650.4159334506353, 3666.1934374437583, 3667.2665466906724, 5390.218418329359, 5486.698231597261, 5494.532964698005, 5507.228987941651, 5528.419515950848, 4190.706650534464, 4719.480857105716, 4829.348038014893, 4855.198892182786, 4905.362302900636, 5129.512696293846, 5625.774969001235, 5717.714114294268, 5996.580239383245, 6021.277446706379, 3918.2555314490155, 3934.0, 3934.704897132698, 3960.4851369321805, 3961.0889495415927, 5477.7261136943, 5994.310654274727, 6179.258488981306, 6222.906656400158, 6289.182406287199, 4045.150518391171, 4047.7571345719352, 4060.2082593893906, 4066.1461093170174, 4081.4081958115908, 3766.8681596144, 3978.403239514038, 4044.6157615026527, 4048.514178298623, 4069.819752271808, 4754.690945088558, 4802.62270176258, 4827.589654879374, 4834.540718631724, 4840.394950631171, 4914.582260507826, 5969.0, 6072.726727297282, 6079.787207447806, 6086.756529738761, 1317.3610798762593, 1341.4097796969302, 1342.241633477102, 1389.249805105252, 1409.4362255097838, 722.147865518693, 819.315871247515, 834.561855026104, 845.564534264854, 852.7356519478982, 4012.1574469361176, 4160.646345060643, 4428.4500424851685, 4614.400127983407, 4710.929336059962, 4435.735815292691, 5105.315245968895, 5151.553012319118, 5180.326557547494, 5193.37679478465, 4185.751462265803, 4396.978015109904, 4688.64835137366, 4725.669203155746, 4752.5485078917445, 2167.8482506224414, 2402.6756387887413, 2651.9602205966926, 2684.0471632570548, 2743.0, 5315.681059136464, 5326.871674452331, 5342.023451323035, 5344.786208551614, 5375.596830237748, 4720.409948756405, 4785.569298763128, 5281.0, 5286.497782710637, 5289.18017707256, 4793.0, 4821.493743156918, 4897.0, 5356.91964620531, 5433.402325744086, 5077.949220507895, 5134.302113566195, 5232.659877108128, 5256.424352067535, 5287.233351164136, 3790.5256570097376, 4524.8416305429155, 4910.299335365463, 4941.072981537275, 5199.896002079861, 4629.629629629689, 4923.384576927884, 5211.690576484036, 5259.16157135444, 5341.75962081715, 3555.4311310190246, 3570.3573356794986, 3817.312883680964, 3939.3697008478507, 4031.596840315945, 5334.506338225303, 6048.213732214784, 6079.3008803988105, 6147.510258345377, 6164.198654174928, 4861.475430312995, 5199.974000129975, 5956.0, 5982.0727787193055, 6035.305939816977, 5386.114859799039, 5535.142052981794, 5704.087346024616, 5968.791092311748, 5979.1928089707335, 5061.392632884077, 5137.614678899023, 5145.71698556568, 5850.268716410449, 5855.502282305882, 5215.55667768244, 5248.973755131353, 5466.528754241006, 5516.255305533701, 5855.531557475477, 5364.30264065669, 5787.94212057874, 5810.593258471867, 5840.269966254218, 5864.589478736448], "value": 4056.3815199721867, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.3984224749862, 766.0960067120799, 787.8384931089128, 794.7933537280308, 816.8243827577072, 15580.610484737874, 15793.368265269375, 15816.683666326666, 15980.520584382488, 16025.278862451189, 14342.856571434282, 14458.132512049284, 14470.782938255908, 14475.638109047253, 14483.0, 674.6525539347216, 833.8790875323075, 834.9540775257359, 864.5720368417642, 873.7553485024204, 740.4483659673524, 858.2061593026457, 873.4366333714781, 875.6497401039603, 875.7854325690215, 904.5160838951163, 928.2017464980112, 931.1154403316842, 931.6925414613162, 933.2207606648457, 890.4078787606234, 902.634433054614, 912.625823412401, 922.9584668689926, 926.6756635177701, 668.3083009085622, 685.5886468119138, 688.3804575881696, 688.4836372720459, 691.3777600159846, 14735.852641473555, 14767.187804670739, 14783.630409239748, 14811.777823332659, 14846.777298340534, 14557.70884582313, 14597.12417254968, 14686.926565367105, 14693.55919322422, 14707.558773236713, 10647.627333043383, 11841.0, 12137.02550290377, 12137.453814578364, 12542.874571254262, 3824.6366595173413, 3838.5393752749846, 4030.234255491447, 4071.9389209161886, 4076.429299898017, 116333.0, 116582.5443757531, 118599.0, 119380.0, 119967.4001629995, 10907.454627268606, 11071.889281107085, 11250.549978000789, 11676.357800320893, 11745.941270293593, 19589.412317630493, 22949.54100918006, 22967.770322296565, 23210.955507002225, 23440.531189376117, 7980.122186559473, 8080.757577272691, 8133.10535841057, 8228.958855205805, 8305.418620696493, 4473.4408198975125, 4486.506484286726, 4505.594496495266, 4525.932111018337, 4688.765561721969, 3549.254656522159, 3647.4164133738473, 3663.358912190356, 3664.853405863789, 3668.908277293089, 639.2776162935853, 642.6850843086854, 654.0679531667355, 672.6334147889412, 672.8284287506655, 583.9328477225173, 592.3217915486744, 597.554821657859, 654.852658151912, 657.980260592183, 8670.219680228809, 8938.284937205008, 9552.95223523878, 9611.327207095435, 9769.951150244204, 568.2719771501071, 625.9718312675941, 627.959182653126, 680.6086500262369, 715.6743681624848, 4441.400410944546, 4580.58774710271, 4863.902721945541, 4877.951220487821, 4899.412070551485, 96258.51870740601, 122707.0, 159274.0, 159283.0, 162641.0, 137017.0, 138891.61108388787, 141019.0, 147821.0, 148222.0, 124101.0, 124952.0, 127283.0, 127859.0, 129964.0, 8063.27430531255, 8473.35058924454, 8693.347998900234, 8943.0, 9284.72145835626, 65642.0, 65813.0, 66326.0, 67087.32912670811, 67378.0, 90829.0, 98923.50538247262, 103253.25600580136, 108929.91070089514, 108992.0, 12019.355741736805, 12027.097967652286, 12222.938885305872, 12559.87440125587, 12751.80872286935, 12649.93675031619, 12984.285864277177, 12985.155964862253, 13024.739505209653, 13131.409086591317, 12254.816177757519, 12274.263544187377, 12302.569410070604, 12309.322987235788, 12564.37178141071, 12317.938410307892, 12424.503019879465, 12449.75100497967, 12510.749785004431, 12593.496260149492, 10009.799804004026, 12086.637400877988, 12102.576409825613, 12115.636530904087, 12187.329696866758, 9484.715458536255, 9584.520773961134, 9601.903980960102, 9618.711438656852, 10048.246381521269, 9405.247580193705, 9667.419954802734, 9735.951320243637, 9847.556859941464, 9943.950280248553], "value": 7805.288919199629, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1577.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 105.0, 116.0, 118.0, 116.0, 114.0, 116.0, 116.0, 96.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 109.0, 132.0, 166.0, 112.0, 136.0, 133.0, 112.0, 160.0, 111.0], "value": 131.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 207.0, 211.0, 258.0, 234.0, 279.0, 271.0, 201.0, 239.0, 219.0], "value": 232.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 83.0, 79.0, 155.0, 59.0, 59.0, 61.0, 66.0, 141.0, 60.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 121.0, 73.0, 72.0, 76.0, 118.0, 71.0, 82.0, 153.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 89.0, 87.0, 90.0, 86.0, 89.0, 86.0, 89.0, 85.0], "value": 87.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 105.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 130.0, 114.0], "value": 101.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 91.0, 91.0, 94.0, 95.0, 91.0, 89.0, 96.0, 148.0, 150.0], "value": 103.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 59.0, 55.0, 57.0, 74.0, 59.0, 59.0, 57.0, 52.0, 49.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 80.0, 69.0, 77.0, 75.0, 107.0, 110.0, 109.0, 72.0, 71.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 84.0, 79.0, 105.0, 101.0, 109.0, 87.0, 88.0, 85.0], "value": 92.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 161.0, 138.0, 134.0, 139.0, 140.0, 141.0, 148.0, 134.0, 157.0], "value": 143.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [222.0, 183.0, 166.0, 171.0, 168.0, 167.0, 167.0, 169.0, 166.0, 165.0], "value": 174.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 79.0, 87.0, 86.0, 87.0, 89.0, 89.0, 72.0, 83.0, 92.0], "value": 83.6, "unit": "score"}]}]} 06:12:13 INFO - Return code: 0 06:12:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:12:13 ERROR - # TBPL SUCCESS # 06:12:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:12:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:12:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:12:13 INFO - 2016-08-08 06:12:13.442 screenresolution[2968:89512] starting screenresolution argv=screenresolution get 06:12:13 INFO - 2016-08-08 06:12:13.445 screenresolution[2968:89512] Display 0: 1600x1200x32@60 06:12:13 INFO - 2016-08-08 06:12:13.452 screenresolution[2969:89515] starting screenresolution argv=screenresolution list 06:12:13 INFO - Available Modes on Display 0 06:12:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:12:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:12:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:12:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:12:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:12:13 INFO - Intel Iris: 06:12:13 INFO - Chipset Model: Intel Iris 06:12:13 INFO - Type: GPU 06:12:13 INFO - Bus: Built-In 06:12:13 INFO - VRAM (Dynamic, Max): 1536 MB 06:12:13 INFO - Vendor: Intel (0x8086) 06:12:13 INFO - Device ID: 0x0a2e 06:12:13 INFO - Revision ID: 0x0009 06:12:13 INFO - Displays: 06:12:13 INFO - Display: 06:12:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:12:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:12:13 INFO - Display Serial Number: 1600x1200 60 06:12:13 INFO - Main Display: Yes 06:12:13 INFO - Mirror: Off 06:12:13 INFO - Online: Yes 06:12:13 INFO - Rotation: Supported 06:12:13 INFO - Return code: 0 06:12:13 INFO - Running post-action listener: _resource_record_post_action 06:12:13 INFO - [mozharness: 2016-08-08 13:12:13.699078Z] Finished run-tests step (success) 06:12:13 INFO - Running post-run listener: _resource_record_post_run 06:12:13 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 0; Write bytes: 702500352; Read time: 0; Write time: 1918 06:12:13 INFO - TinderboxPrint: CPU usage
54.4% 06:12:13 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:12:13 INFO - TinderboxPrint: I/O write bytes / time
702,500,352 / 1,918 06:12:13 INFO - TinderboxPrint: CPU idle
2,207.8 (45.6%) 06:12:13 INFO - TinderboxPrint: CPU system
977.5 (20.2%) 06:12:13 INFO - TinderboxPrint: CPU user
1,656.3 (34.2%) 06:12:13 INFO - TinderboxPrint: Swap in / out
406,196,224 / 0 06:12:13 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 387688960; Write bytes: 382285312; Read time: 28901; Write time: 751 06:12:13 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 0; Write bytes: 292796416; Read time: 0; Write time: 1102 06:12:14 INFO - Running post-run listener: _upload_blobber_files 06:12:14 INFO - Blob upload gear active. 06:12:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:12:14 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 06:12:14 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'] 06:12:14 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 06:12:14 INFO - (blobuploader) - INFO - Open directory for files ... 06:12:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:12:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:12:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:15 INFO - (blobuploader) - INFO - Done attempting. 06:12:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:12:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:12:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:16 INFO - (blobuploader) - INFO - Done attempting. 06:12:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:12:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:12:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:19 INFO - (blobuploader) - INFO - Done attempting. 06:12:19 INFO - (blobuploader) - INFO - Iteration through files over. 06:12:19 INFO - Return code: 0 06:12:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:12:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:12:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/acfbfc5f2fc6a9f52cf7116cd812193405038c5cb923821a8233e54373539f6011da2a46a1dca29349446b9101594aef0a7c604d5f1e362c880d6370fc2bdeab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec30c23ccd2f537dbf7a881f124aaee2cfc11e994dc01e3e48d40f4b637dd021b41c82373029168066eb7c5227cdf1038db651529b8e6e6b5219e897efc7ba7d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d7cd1d00b64bb442f83ad29db3175cf0e8c641c68b45b404755d44fc9d61c04c30b3d5f95248bc737c6ee7886248f21d84d2030ac756e9036f529c766bc9b4fd"} 06:12:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:12:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:12:19 INFO - Contents: 06:12:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/acfbfc5f2fc6a9f52cf7116cd812193405038c5cb923821a8233e54373539f6011da2a46a1dca29349446b9101594aef0a7c604d5f1e362c880d6370fc2bdeab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec30c23ccd2f537dbf7a881f124aaee2cfc11e994dc01e3e48d40f4b637dd021b41c82373029168066eb7c5227cdf1038db651529b8e6e6b5219e897efc7ba7d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d7cd1d00b64bb442f83ad29db3175cf0e8c641c68b45b404755d44fc9d61c04c30b3d5f95248bc737c6ee7886248f21d84d2030ac756e9036f529c766bc9b4fd"} 06:12:19 INFO - Running post-run listener: copy_logs_to_upload_dir 06:12:19 INFO - Copying logs to upload dir... 06:12:19 INFO - mkdir: /builds/slave/test/build/upload/logs 06:12:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.672819 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-08-08 06:12:19.268983) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 06:12:19.272690) ========= 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.uOjtYYgBh1/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.MvdrBawwiL/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/acfbfc5f2fc6a9f52cf7116cd812193405038c5cb923821a8233e54373539f6011da2a46a1dca29349446b9101594aef0a7c604d5f1e362c880d6370fc2bdeab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec30c23ccd2f537dbf7a881f124aaee2cfc11e994dc01e3e48d40f4b637dd021b41c82373029168066eb7c5227cdf1038db651529b8e6e6b5219e897efc7ba7d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d7cd1d00b64bb442f83ad29db3175cf0e8c641c68b45b404755d44fc9d61c04c30b3d5f95248bc737c6ee7886248f21d84d2030ac756e9036f529c766bc9b4fd"} build_url:https://queue.taskcluster.net/v1/task/MrLTufnlSjSGjQZ3NLyTHg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011611 build_url: 'https://queue.taskcluster.net/v1/task/MrLTufnlSjSGjQZ3NLyTHg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/acfbfc5f2fc6a9f52cf7116cd812193405038c5cb923821a8233e54373539f6011da2a46a1dca29349446b9101594aef0a7c604d5f1e362c880d6370fc2bdeab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec30c23ccd2f537dbf7a881f124aaee2cfc11e994dc01e3e48d40f4b637dd021b41c82373029168066eb7c5227cdf1038db651529b8e6e6b5219e897efc7ba7d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d7cd1d00b64bb442f83ad29db3175cf0e8c641c68b45b404755d44fc9d61c04c30b3d5f95248bc737c6ee7886248f21d84d2030ac756e9036f529c766bc9b4fd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 06:12:19.305205) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 06:12:19.305512) ========= 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.uOjtYYgBh1/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.MvdrBawwiL/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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.005251 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 06:12:19.354136) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 06:12:19.354448) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 06:12:19.354753) ========= ========= Total master_lag: 0.18 =========