builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0321 starttime: 1470991633.6 results: success (0) buildid: 20160811234715 builduid: ee95c4a3a06c44b3932f8bc490d6e751 revision: 666549adf9c64d9756bc77319570440e04be7ad7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 01:47:13.603213) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 01:47:13.603670) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 01:47:13.603967) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 01:47:13.926090) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 01:47:13.926355) ========= 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.lUmXLFd2oC/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.1dq94XUI3Z/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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-12 01:47:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.23M=0.001s 2016-08-12 01:47:14 (8.23 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.529576 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 01:47:14.487749) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 01:47:14.488077) ========= 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.lUmXLFd2oC/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.1dq94XUI3Z/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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.020698 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 01:47:14.539495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-12 01:47:14.540045) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 666549adf9c64d9756bc77319570440e04be7ad7 --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 666549adf9c64d9756bc77319570440e04be7ad7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lUmXLFd2oC/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.1dq94XUI3Z/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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-12 01:47:14,622 truncating revision to first 12 chars 2016-08-12 01:47:14,622 Setting DEBUG logging. 2016-08-12 01:47:14,622 attempt 1/10 2016-08-12 01:47:14,622 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/666549adf9c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-12 01:47:15,591 unpacking tar archive at: fx-team-666549adf9c6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.247961 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-12 01:47:15.811284) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 01:47:15.811600) ========= script_repo_revision: 666549adf9c64d9756bc77319570440e04be7ad7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 01:47:15.811979) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 01:47:15.812258) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 01:47:15.832504) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-08-12 01:47:15.833252) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lUmXLFd2oC/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.1dq94XUI3Z/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 01:47:16 INFO - MultiFileLogger online at 20160812 01:47:16 in /builds/slave/test 01:47:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 01:47:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:47:16 INFO - {'append_to_log': False, 01:47:16 INFO - 'base_work_dir': '/builds/slave/test', 01:47:16 INFO - 'blob_upload_branch': 'Fx-Team', 01:47:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:47:16 INFO - 'branch': 'Fx-Team', 01:47:16 INFO - 'buildbot_json_path': 'buildprops.json', 01:47:16 INFO - 'config_files': ('talos/mac_config.py',), 01:47:16 INFO - 'default_actions': ('clobber', 01:47:16 INFO - 'read-buildbot-config', 01:47:16 INFO - 'download-and-extract', 01:47:16 INFO - 'populate-webroot', 01:47:16 INFO - 'create-virtualenv', 01:47:16 INFO - 'install', 01:47:16 INFO - 'run-tests'), 01:47:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:47:16 INFO - 'download_minidump_stackwalk': True, 01:47:16 INFO - 'download_symbols': 'ondemand', 01:47:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:47:16 INFO - 'tooltool.py': '/tools/tooltool.py', 01:47:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:47:16 INFO - '/tools/misc-python/virtualenv.py')}, 01:47:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:47:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:47:16 INFO - 'installer_path': 'installer.exe', 01:47:16 INFO - 'log_level': 'info', 01:47:16 INFO - 'log_name': 'talos', 01:47:16 INFO - 'log_to_console': True, 01:47:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:47:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:47:16 INFO - 'opt_config_files': (), 01:47:16 INFO - 'pip_index': False, 01:47:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:47:16 INFO - 'cmd': ('bash', 01:47:16 INFO - '-c', 01:47:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:47:16 INFO - 'enabled': True, 01:47:16 INFO - 'halt_on_failure': False, 01:47:16 INFO - 'name': 'check_screen_resolution'},), 01:47:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:47:16 INFO - 'cmd': ('bash', 01:47:16 INFO - '-c', 01:47:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:47:16 INFO - 'enabled': True, 01:47:16 INFO - 'halt_on_failure': False, 01:47:16 INFO - 'name': 'check_screen_resolution'},), 01:47:16 INFO - 'run_cmd_checks_enabled': True, 01:47:16 INFO - 'sps_profile': False, 01:47:16 INFO - 'sps_profile_interval': 0, 01:47:16 INFO - 'suite': 'dromaeojs', 01:47:16 INFO - 'system_bits': '32', 01:47:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:47:16 INFO - 'title': 't-yosemite-r7-0321', 01:47:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:47:16 INFO - 'use_talos_json': True, 01:47:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:47:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:47:16 INFO - 'work_dir': 'build'} 01:47:16 INFO - [mozharness: 2016-08-12 08:47:16.020047Z] Running clobber step. 01:47:16 INFO - Running pre-action listener: _resource_record_pre_action 01:47:16 INFO - Running main action method: clobber 01:47:16 INFO - rmtree: /builds/slave/test/build 01:47:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:47:17 INFO - Running post-action listener: _resource_record_post_action 01:47:17 INFO - [mozharness: 2016-08-12 08:47:17.821548Z] Finished clobber step (success) 01:47:17 INFO - [mozharness: 2016-08-12 08:47:17.821713Z] Running read-buildbot-config step. 01:47:17 INFO - Running pre-action listener: _resource_record_pre_action 01:47:17 INFO - Running main action method: read_buildbot_config 01:47:17 INFO - Using buildbot properties: 01:47:17 INFO - { 01:47:17 INFO - "project": "", 01:47:17 INFO - "product": "firefox", 01:47:17 INFO - "script_repo_revision": "production", 01:47:17 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 01:47:17 INFO - "repository": "", 01:47:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 01:47:17 INFO - "buildid": "20160811234715", 01:47:17 INFO - "pgo_build": "False", 01:47:17 INFO - "basedir": "/builds/slave/test", 01:47:17 INFO - "buildnumber": 120, 01:47:17 INFO - "slavename": "t-yosemite-r7-0321", 01:47:17 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 01:47:17 INFO - "platform": "yosemite_r7", 01:47:17 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 01:47:17 INFO - "branch": "fx-team", 01:47:17 INFO - "repo_path": "integration/fx-team", 01:47:17 INFO - "revision": "666549adf9c64d9756bc77319570440e04be7ad7", 01:47:17 INFO - "stage_platform": "macosx64", 01:47:17 INFO - "builduid": "ee95c4a3a06c44b3932f8bc490d6e751", 01:47:17 INFO - "slavebuilddir": "test" 01:47:17 INFO - } 01:47:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/QCojeHmkRmGpUeV3vJV5-w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 01:47:17 INFO - Running post-action listener: _resource_record_post_action 01:47:17 INFO - [mozharness: 2016-08-12 08:47:17.825115Z] Finished read-buildbot-config step (success) 01:47:17 INFO - [mozharness: 2016-08-12 08:47:17.825233Z] Running download-and-extract step. 01:47:17 INFO - Running pre-action listener: _resource_record_pre_action 01:47:17 INFO - Running main action method: download_and_extract 01:47:17 INFO - mkdir: /builds/slave/test/build/tests 01:47:17 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')]} 01:47:17 INFO - trying https://queue.taskcluster.net/v1/task/QCojeHmkRmGpUeV3vJV5-w/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 01:47:17 INFO - Downloading https://queue.taskcluster.net/v1/task/QCojeHmkRmGpUeV3vJV5-w/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 01:47:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QCojeHmkRmGpUeV3vJV5-w/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 01:47:19 INFO - Downloaded 1199 bytes. 01:47:19 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 01:47:19 INFO - Using the following test package requirements: 01:47:19 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 01:47:19 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:47:19 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 01:47:19 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:47:19 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 01:47:19 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:47:19 INFO - u'jsshell-mac.zip'], 01:47:19 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:47:19 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 01:47:19 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 01:47:19 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:47:19 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 01:47:19 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:47:19 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 01:47:19 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:47:19 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 01:47:19 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:47:19 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 01:47:19 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:47:19 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')]} 01:47:19 INFO - trying https://queue.taskcluster.net/v1/task/QCojeHmkRmGpUeV3vJV5-w/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 01:47:19 INFO - Downloading https://queue.taskcluster.net/v1/task/QCojeHmkRmGpUeV3vJV5-w/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 01:47:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QCojeHmkRmGpUeV3vJV5-w/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 01:47:20 INFO - Downloaded 16328266 bytes. 01:47:20 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'] 01:47:20 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 01:47:23 INFO - Return code: 0 01:47:23 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 01:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:47:23 INFO - trying https://queue.taskcluster.net/v1/task/QCojeHmkRmGpUeV3vJV5-w/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 01:47:23 INFO - Downloading https://queue.taskcluster.net/v1/task/QCojeHmkRmGpUeV3vJV5-w/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 01:47:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QCojeHmkRmGpUeV3vJV5-w/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 01:47:24 INFO - Downloaded 16328266 bytes. 01:47:24 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'] 01:47:24 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 01:47:28 INFO - Return code: 0 01:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:47:28 INFO - trying https://queue.taskcluster.net/v1/task/QCojeHmkRmGpUeV3vJV5-w/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 01:47:28 INFO - Downloading https://queue.taskcluster.net/v1/task/QCojeHmkRmGpUeV3vJV5-w/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 01:47:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QCojeHmkRmGpUeV3vJV5-w/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 01:47:30 INFO - Downloaded 14413719 bytes. 01:47:30 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'] 01:47:30 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 01:47:30 INFO - Return code: 0 01:47:30 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')]} 01:47:30 INFO - trying https://queue.taskcluster.net/v1/task/QCojeHmkRmGpUeV3vJV5-w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 01:47:30 INFO - Downloading https://queue.taskcluster.net/v1/task/QCojeHmkRmGpUeV3vJV5-w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 01:47:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QCojeHmkRmGpUeV3vJV5-w/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 01:47:33 INFO - Downloaded 110895502 bytes. 01:47:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QCojeHmkRmGpUeV3vJV5-w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 01:47:33 INFO - mkdir: /builds/slave/test/properties 01:47:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:47:33 INFO - Writing to file /builds/slave/test/properties/build_url 01:47:33 INFO - Contents: 01:47:33 INFO - build_url:https://queue.taskcluster.net/v1/task/QCojeHmkRmGpUeV3vJV5-w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 01:47:34 INFO - Running post-action listener: _resource_record_post_action 01:47:34 INFO - Running post-action listener: set_extra_try_arguments 01:47:34 INFO - [mozharness: 2016-08-12 08:47:34.068201Z] Finished download-and-extract step (success) 01:47:34 INFO - [mozharness: 2016-08-12 08:47:34.068342Z] Running populate-webroot step. 01:47:34 INFO - Running pre-action listener: _resource_record_pre_action 01:47:34 INFO - Running main action method: populate_webroot 01:47:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:47:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:47:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:47:34 INFO - '--tppagecycles', 01:47:34 INFO - '7'], 01:47:34 INFO - 'tests': ['tsvgm']}}, 01:47:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:47:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:47:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:47:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:47:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:47:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:47:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:34 INFO - 'talos_options': ['--disable-e10s'], 01:47:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:47:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:47:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:34 INFO - 'talos_options': ['--disable-e10s'], 01:47:34 INFO - 'tests': ['damp', 'tps']}, 01:47:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:34 INFO - 'tests': ['damp', 'tps']}, 01:47:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:47:34 INFO - 'tests': ['dromaeo_dom']}, 01:47:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:47:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:47:34 INFO - 'tests': ['basic_compositor_video']}, 01:47:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:47:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:47:34 INFO - 'tests': ['a11yr', 01:47:34 INFO - 'ts_paint', 01:47:34 INFO - 'tpaint', 01:47:34 INFO - 'sessionrestore', 01:47:34 INFO - 'sessionrestore_no_auto_restore', 01:47:34 INFO - 'tabpaint']}, 01:47:34 INFO - 'other-e10s': {'tests': ['a11yr', 01:47:34 INFO - 'ts_paint', 01:47:34 INFO - 'tpaint', 01:47:34 INFO - 'sessionrestore', 01:47:34 INFO - 'sessionrestore_no_auto_restore', 01:47:34 INFO - 'tabpaint']}, 01:47:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:47:34 INFO - 'ts_paint', 01:47:34 INFO - 'tpaint', 01:47:34 INFO - 'sessionrestore', 01:47:34 INFO - 'sessionrestore_no_auto_restore', 01:47:34 INFO - 'tabpaint']}, 01:47:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:47:34 INFO - 'ts_paint', 01:47:34 INFO - 'tpaint', 01:47:34 INFO - 'sessionrestore', 01:47:34 INFO - 'sessionrestore_no_auto_restore', 01:47:34 INFO - 'tabpaint']}, 01:47:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:47:34 INFO - 'tests': ['a11yr', 01:47:34 INFO - 'ts_paint', 01:47:34 INFO - 'tpaint', 01:47:34 INFO - 'sessionrestore', 01:47:34 INFO - 'sessionrestore_no_auto_restore', 01:47:34 INFO - 'tabpaint']}, 01:47:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:47:34 INFO - 'tests': ['a11yr', 01:47:34 INFO - 'ts_paint', 01:47:34 INFO - 'tpaint', 01:47:34 INFO - 'sessionrestore', 01:47:34 INFO - 'sessionrestore_no_auto_restore', 01:47:34 INFO - 'tabpaint']}, 01:47:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:47:34 INFO - 'tests': ['tsvgx', 01:47:34 INFO - 'tsvgr_opacity', 01:47:34 INFO - 'tart', 01:47:34 INFO - 'tscrollx', 01:47:34 INFO - 'cart']}, 01:47:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:47:34 INFO - 'tsvgr_opacity', 01:47:34 INFO - 'tart', 01:47:34 INFO - 'tscrollx', 01:47:34 INFO - 'cart']}, 01:47:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:34 INFO - 'talos_options': ['--disable-e10s'], 01:47:34 INFO - 'tests': ['tp5o']}, 01:47:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:34 INFO - 'tests': ['tp5o']}, 01:47:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:34 INFO - 'talos_options': ['--disable-e10s', 01:47:34 INFO - '--xperf_path', 01:47:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:47:34 INFO - 'tests': ['tp5n']}, 01:47:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:47:34 INFO - 'talos_options': ['--xperf_path', 01:47:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:47:34 INFO - 'tests': ['tp5n']}}, 01:47:34 INFO - 'talos.zip': {'path': '', 01:47:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:47:34 INFO - Running post-action listener: _resource_record_post_action 01:47:34 INFO - [mozharness: 2016-08-12 08:47:34.087181Z] Finished populate-webroot step (success) 01:47:34 INFO - [mozharness: 2016-08-12 08:47:34.087266Z] Running create-virtualenv step. 01:47:34 INFO - Running pre-action listener: _resource_record_pre_action 01:47:34 INFO - Running main action method: create_virtualenv 01:47:34 INFO - Creating virtualenv /builds/slave/test/build/venv 01:47:34 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:47:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:47:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:47:34 INFO - Using real prefix '/tools/python27' 01:47:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:47:34 INFO - Installing distribute.............................................................................................................................................................................................done. 01:47:37 INFO - Installing pip.................done. 01:47:37 INFO - Return code: 0 01:47:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:47: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')]} 01:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47: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')]} 01:47:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:37 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 0x101104a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101199618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4825c21d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101068d30>, '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 0x100dcddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101060b20>, '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.lUmXLFd2oC/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.1dq94XUI3Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 01:47:37 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 01:47:37 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 01:47:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lUmXLFd2oC/Render', 01:47:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:47:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:47:37 INFO - 'HOME': '/Users/cltbld', 01:47:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:47:37 INFO - 'LOGNAME': 'cltbld', 01:47:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:37 INFO - 'MOZ_NO_REMOTE': '1', 01:47:37 INFO - 'NO_EM_RESTART': '1', 01:47:37 INFO - 'PAGER': '/bin/cat', 01:47:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:47:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:37 INFO - 'PWD': '/builds/slave/test', 01:47:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:47:37 INFO - 'SHELL': '/bin/bash', 01:47:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1dq94XUI3Z/Listeners', 01:47:37 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 01:47:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:47:37 INFO - 'USER': 'cltbld', 01:47:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:47:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:47:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:37 INFO - 'XPC_FLAGS': '0x0', 01:47:37 INFO - 'XPC_SERVICE_NAME': '0', 01:47:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:47:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:47:38 INFO - Cleaning up... 01:47:38 INFO - Return code: 0 01:47:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:47:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:47:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101104a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101199618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4825c21d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101068d30>, '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 0x100dcddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101060b20>, '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.lUmXLFd2oC/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.1dq94XUI3Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 01:47:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:47:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:47:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lUmXLFd2oC/Render', 01:47:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:47:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:47:38 INFO - 'HOME': '/Users/cltbld', 01:47:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:47:38 INFO - 'LOGNAME': 'cltbld', 01:47:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:38 INFO - 'MOZ_NO_REMOTE': '1', 01:47:38 INFO - 'NO_EM_RESTART': '1', 01:47:38 INFO - 'PAGER': '/bin/cat', 01:47:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:47:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:38 INFO - 'PWD': '/builds/slave/test', 01:47:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:47:38 INFO - 'SHELL': '/bin/bash', 01:47:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1dq94XUI3Z/Listeners', 01:47:38 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 01:47:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:47:38 INFO - 'USER': 'cltbld', 01:47:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:47:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:47:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:38 INFO - 'XPC_FLAGS': '0x0', 01:47:38 INFO - 'XPC_SERVICE_NAME': '0', 01:47:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:47:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:38 INFO - Downloading/unpacking psutil>=3.1.1 01:47:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:47:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:47:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:47:42 INFO - Installing collected packages: psutil 01:47:42 INFO - Running setup.py install for psutil 01:47:42 INFO - building 'psutil._psutil_osx' extension 01:47:42 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 01:47:42 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 01:47:42 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 01:47:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 01:47:42 INFO - building 'psutil._psutil_posix' extension 01:47:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 01:47:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:47:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:47:42 INFO - ^ 01:47:42 INFO - 1 warning generated. 01:47:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 01:47:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:47:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:47:42 INFO - Successfully installed psutil 01:47:42 INFO - Cleaning up... 01:47:43 INFO - Return code: 0 01:47:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:47: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')]} 01:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47: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')]} 01:47:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101104a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101199618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4825c21d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101068d30>, '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 0x100dcddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101060b20>, '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.lUmXLFd2oC/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.1dq94XUI3Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 01:47: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:47: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 mozsystemmonitor==0.3 01:47:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lUmXLFd2oC/Render', 01:47:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:47:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:47:43 INFO - 'HOME': '/Users/cltbld', 01:47:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:47:43 INFO - 'LOGNAME': 'cltbld', 01:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:43 INFO - 'MOZ_NO_REMOTE': '1', 01:47:43 INFO - 'NO_EM_RESTART': '1', 01:47:43 INFO - 'PAGER': '/bin/cat', 01:47:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:43 INFO - 'PWD': '/builds/slave/test', 01:47:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:47:43 INFO - 'SHELL': '/bin/bash', 01:47:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1dq94XUI3Z/Listeners', 01:47:43 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 01:47:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:47:43 INFO - 'USER': 'cltbld', 01:47:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:47:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:43 INFO - 'XPC_FLAGS': '0x0', 01:47:43 INFO - 'XPC_SERVICE_NAME': '0', 01:47:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:47:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:47: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 01:47: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 01:47: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 01:47: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 01:47: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 01:47: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 01:47:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:47:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:47:45 INFO - Installing collected packages: mozsystemmonitor 01:47:45 INFO - Running setup.py install for mozsystemmonitor 01:47:46 INFO - Successfully installed mozsystemmonitor 01:47:46 INFO - Cleaning up... 01:47:46 INFO - Return code: 0 01:47:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:47: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')]} 01:47:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47: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')]} 01:47:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47: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', '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 0x101104a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101199618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4825c21d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101068d30>, '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 0x100dcddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101060b20>, '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.lUmXLFd2oC/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.1dq94XUI3Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 01:47: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:47: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 jsonschema==2.5.1 01:47:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lUmXLFd2oC/Render', 01:47:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:47:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:47:46 INFO - 'HOME': '/Users/cltbld', 01:47:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:47:46 INFO - 'LOGNAME': 'cltbld', 01:47:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:46 INFO - 'MOZ_NO_REMOTE': '1', 01:47:46 INFO - 'NO_EM_RESTART': '1', 01:47:46 INFO - 'PAGER': '/bin/cat', 01:47:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:47:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:46 INFO - 'PWD': '/builds/slave/test', 01:47:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:47:46 INFO - 'SHELL': '/bin/bash', 01:47:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1dq94XUI3Z/Listeners', 01:47:46 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 01:47:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:47:46 INFO - 'USER': 'cltbld', 01:47:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:47:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:47:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:46 INFO - 'XPC_FLAGS': '0x0', 01:47:46 INFO - 'XPC_SERVICE_NAME': '0', 01:47:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:47:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:46 INFO - Downloading/unpacking jsonschema==2.5.1 01:47: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 01:47: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 01:47: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 01:47: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 01:47: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 01:47: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 01:47:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:47:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:49 INFO - Downloading functools32-3.2.3-2.tar.gz 01:47:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:47:49 INFO - warning: no files found matching '*.txt' 01:47:49 INFO - no previously-included directories found matching 'build' 01:47:49 INFO - no previously-included directories found matching 'dist' 01:47:49 INFO - no previously-included directories found matching '.git*' 01:47:49 INFO - Installing collected packages: jsonschema, functools32 01:47:49 INFO - Running setup.py install for functools32 01:47:49 INFO - warning: no files found matching '*.txt' 01:47:49 INFO - no previously-included directories found matching 'build' 01:47:49 INFO - no previously-included directories found matching 'dist' 01:47:49 INFO - no previously-included directories found matching '.git*' 01:47:49 INFO - Successfully installed jsonschema functools32 01:47:49 INFO - Cleaning up... 01:47:49 INFO - Return code: 0 01:47:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:47:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:47:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:49 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 0x101104a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101199618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4825c21d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101068d30>, '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 0x100dcddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101060b20>, '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.lUmXLFd2oC/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.1dq94XUI3Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 01:47:49 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 01:47:49 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 01:47:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lUmXLFd2oC/Render', 01:47:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:47:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:47:49 INFO - 'HOME': '/Users/cltbld', 01:47:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:47:49 INFO - 'LOGNAME': 'cltbld', 01:47:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:49 INFO - 'MOZ_NO_REMOTE': '1', 01:47:49 INFO - 'NO_EM_RESTART': '1', 01:47:49 INFO - 'PAGER': '/bin/cat', 01:47:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:47:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:49 INFO - 'PWD': '/builds/slave/test', 01:47:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:47:49 INFO - 'SHELL': '/bin/bash', 01:47:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1dq94XUI3Z/Listeners', 01:47:49 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 01:47:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:47:49 INFO - 'USER': 'cltbld', 01:47:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:47:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:47:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:49 INFO - 'XPC_FLAGS': '0x0', 01:47:49 INFO - 'XPC_SERVICE_NAME': '0', 01:47:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:47:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:47:49 INFO - Cleaning up... 01:47:49 INFO - Return code: 0 01:47:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:47:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:47:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:49 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 0x101104a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101199618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4825c21d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101068d30>, '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 0x100dcddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101060b20>, '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.lUmXLFd2oC/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.1dq94XUI3Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 01:47:49 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 01:47:49 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 01:47:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lUmXLFd2oC/Render', 01:47:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:47:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:47:49 INFO - 'HOME': '/Users/cltbld', 01:47:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:47:49 INFO - 'LOGNAME': 'cltbld', 01:47:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:49 INFO - 'MOZ_NO_REMOTE': '1', 01:47:49 INFO - 'NO_EM_RESTART': '1', 01:47:49 INFO - 'PAGER': '/bin/cat', 01:47:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:47:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:49 INFO - 'PWD': '/builds/slave/test', 01:47:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:47:49 INFO - 'SHELL': '/bin/bash', 01:47:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1dq94XUI3Z/Listeners', 01:47:49 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 01:47:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:47:49 INFO - 'USER': 'cltbld', 01:47:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:47:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:47:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:49 INFO - 'XPC_FLAGS': '0x0', 01:47:49 INFO - 'XPC_SERVICE_NAME': '0', 01:47:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:47:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:50 INFO - Downloading/unpacking blobuploader==1.2.4 01:47: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 01:47: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 01:47: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 01:47: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 01:47: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 01:47: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 01:47:52 INFO - Downloading blobuploader-1.2.4.tar.gz 01:47:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:47:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:47:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:47:53 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 01:47:53 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 01:47:53 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 01:47:53 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 01:47:53 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 01:47:53 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 01:47:53 INFO - Downloading docopt-0.6.1.tar.gz 01:47:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:47:53 INFO - Installing collected packages: blobuploader, requests, docopt 01:47:53 INFO - Running setup.py install for blobuploader 01:47:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:47:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:47:53 INFO - Running setup.py install for requests 01:47:54 INFO - Running setup.py install for docopt 01:47:54 INFO - Successfully installed blobuploader requests docopt 01:47:54 INFO - Cleaning up... 01:47:54 INFO - Return code: 0 01:47:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:47:54 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')]} 01:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:54 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')]} 01:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:54 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 0x101104a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101199618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4825c21d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101068d30>, '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 0x100dcddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101060b20>, '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.lUmXLFd2oC/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.1dq94XUI3Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 01:47:54 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 01:47:54 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 01:47:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lUmXLFd2oC/Render', 01:47:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:47:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:47:54 INFO - 'HOME': '/Users/cltbld', 01:47:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:47:54 INFO - 'LOGNAME': 'cltbld', 01:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:54 INFO - 'MOZ_NO_REMOTE': '1', 01:47:54 INFO - 'NO_EM_RESTART': '1', 01:47:54 INFO - 'PAGER': '/bin/cat', 01:47:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:54 INFO - 'PWD': '/builds/slave/test', 01:47:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:47:54 INFO - 'SHELL': '/bin/bash', 01:47:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1dq94XUI3Z/Listeners', 01:47:54 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 01:47:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:47:54 INFO - 'USER': 'cltbld', 01:47:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:47:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:54 INFO - 'XPC_FLAGS': '0x0', 01:47:54 INFO - 'XPC_SERVICE_NAME': '0', 01:47:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:47:54 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-agx4Pb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:47:55 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-P_rwqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:47:55 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-wMaOpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:47:55 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-XsZc_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:47:55 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-p26l40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:47:55 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-lpsa6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:47:55 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-YBJznl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:47:55 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-DW3LZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:47:55 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-MvAmPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:47:55 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-YZ_eIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:47:55 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-ZZAfW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:47:56 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-kF5Y2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:47:56 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-pfIbTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:47:56 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-doyjMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:47:56 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-Fut1YT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:47:56 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-W3Eq2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:47:56 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-oVaN5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:47:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:47:56 INFO - Running setup.py install for manifestparser 01:47:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:47:56 INFO - Running setup.py install for mozcrash 01:47:57 INFO - Running setup.py install for mozdebug 01:47:57 INFO - Running setup.py install for mozdevice 01:47:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:47:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:47:57 INFO - Running setup.py install for mozfile 01:47:57 INFO - Running setup.py install for mozhttpd 01:47:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:47:57 INFO - Running setup.py install for mozinfo 01:47:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:47:57 INFO - Running setup.py install for mozInstall 01:47:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:47:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:47:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:47:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:47:57 INFO - Running setup.py install for mozleak 01:47:58 INFO - Running setup.py install for mozlog 01:47:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:47:58 INFO - Running setup.py install for moznetwork 01:47:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:47:58 INFO - Running setup.py install for mozprocess 01:47:58 INFO - Running setup.py install for mozprofile 01:47:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:47:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:47:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:47:58 INFO - Running setup.py install for mozrunner 01:47:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:47:58 INFO - Running setup.py install for mozscreenshot 01:47:59 INFO - Running setup.py install for moztest 01:47:59 INFO - Running setup.py install for mozversion 01:47:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:47:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:47:59 INFO - Cleaning up... 01:47:59 INFO - Return code: 0 01:47:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:47:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:59 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 0x101104a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101199618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4825c21d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101068d30>, '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 0x100dcddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101060b20>, '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.lUmXLFd2oC/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.1dq94XUI3Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 01:47:59 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 01:47:59 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 01:47:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lUmXLFd2oC/Render', 01:47:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:47:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:47:59 INFO - 'HOME': '/Users/cltbld', 01:47:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:47:59 INFO - 'LOGNAME': 'cltbld', 01:47:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:59 INFO - 'MOZ_NO_REMOTE': '1', 01:47:59 INFO - 'NO_EM_RESTART': '1', 01:47:59 INFO - 'PAGER': '/bin/cat', 01:47:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:47:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:59 INFO - 'PWD': '/builds/slave/test', 01:47:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:47:59 INFO - 'SHELL': '/bin/bash', 01:47:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1dq94XUI3Z/Listeners', 01:47:59 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 01:47:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:47:59 INFO - 'USER': 'cltbld', 01:47:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:47:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:47:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:59 INFO - 'XPC_FLAGS': '0x0', 01:47:59 INFO - 'XPC_SERVICE_NAME': '0', 01:47:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:47:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:47:59 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-71PKjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:47:59 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)) 01:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:47:59 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-iwfKYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:47:59 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)) 01:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:47:59 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-yTtF2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:47:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:47:59 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-cy_mw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:48:00 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)) 01:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:48:00 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-HRV9MZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:48:00 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)) 01:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:48:00 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-efc_1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:48:00 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)) 01:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:48:00 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-wt3XzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:48:00 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)) 01:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:48:00 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-BNB1S1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:48:00 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)) 01:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:48:00 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-xoLekJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:48:00 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)) 01:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:48:00 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-MfTsfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:48:00 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)) 01:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:48:00 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-prnc7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:48:00 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)) 01:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:48:00 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-1X45Ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:48:00 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)) 01:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:48:00 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-6gcMBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:48:01 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)) 01:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:48:01 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-w0jwH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:48:01 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)) 01:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:48:01 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-9SFe9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:48:01 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)) 01:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:48:01 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-F729FO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:48:01 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)) 01:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:48:01 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-PMApxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:48:01 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)) 01:48:01 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)) 01:48:01 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)) 01:48:01 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)) 01:48:01 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)) 01:48:01 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)) 01:48:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:03 INFO - Downloading blessings-1.6.tar.gz 01:48:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:48:03 INFO - Installing collected packages: blessings 01:48:03 INFO - Running setup.py install for blessings 01:48:04 INFO - Successfully installed blessings 01:48:04 INFO - Cleaning up... 01:48:04 INFO - Return code: 0 01:48:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:48:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:48:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:48:04 INFO - Reading from file tmpfile_stdout 01:48:04 INFO - Current package versions: 01:48:04 INFO - blessings == 1.6 01:48:04 INFO - blobuploader == 1.2.4 01:48:04 INFO - docopt == 0.6.1 01:48:04 INFO - functools32 == 3.2.3-2 01:48:04 INFO - jsonschema == 2.5.1 01:48:04 INFO - manifestparser == 1.1 01:48:04 INFO - mozInstall == 1.12 01:48:04 INFO - mozcrash == 0.17 01:48:04 INFO - mozdebug == 0.1 01:48:04 INFO - mozdevice == 0.48 01:48:04 INFO - mozfile == 1.2 01:48:04 INFO - mozhttpd == 0.7 01:48:04 INFO - mozinfo == 0.9 01:48:04 INFO - mozleak == 0.1 01:48:04 INFO - mozlog == 3.3 01:48:04 INFO - moznetwork == 0.27 01:48:04 INFO - mozprocess == 0.23 01:48:04 INFO - mozprofile == 0.28 01:48:04 INFO - mozrunner == 6.12 01:48:04 INFO - mozscreenshot == 0.1 01:48:04 INFO - mozsystemmonitor == 0.3 01:48:04 INFO - moztest == 0.7 01:48:04 INFO - mozversion == 1.4 01:48:04 INFO - psutil == 3.1.1 01:48:04 INFO - requests == 1.2.3 01:48:04 INFO - wsgiref == 0.1.2 01:48:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:04 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 0x101104a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101199618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4825c21d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101068d30>, '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 0x100dcddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101060b20>, '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.lUmXLFd2oC/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.1dq94XUI3Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 01:48:04 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 01:48:04 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 01:48:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lUmXLFd2oC/Render', 01:48:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:04 INFO - 'HOME': '/Users/cltbld', 01:48:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:04 INFO - 'LOGNAME': 'cltbld', 01:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:04 INFO - 'MOZ_NO_REMOTE': '1', 01:48:04 INFO - 'NO_EM_RESTART': '1', 01:48:04 INFO - 'PAGER': '/bin/cat', 01:48:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:04 INFO - 'PWD': '/builds/slave/test', 01:48:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:04 INFO - 'SHELL': '/bin/bash', 01:48:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1dq94XUI3Z/Listeners', 01:48:04 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 01:48:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:04 INFO - 'USER': 'cltbld', 01:48:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:04 INFO - 'XPC_FLAGS': '0x0', 01:48:04 INFO - 'XPC_SERVICE_NAME': '0', 01:48:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:04 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)) 01:48:04 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)) 01:48:04 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)) 01:48:04 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)) 01:48:04 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)) 01:48:04 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)) 01:48:04 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)) 01:48:04 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)) 01:48:04 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)) 01:48:04 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)) 01:48:04 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)) 01:48:04 INFO - Cleaning up... 01:48:04 INFO - Return code: 0 01:48:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:04 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 0x101104a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101199618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4825c21d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101068d30>, '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 0x100dcddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101060b20>, '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.lUmXLFd2oC/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.1dq94XUI3Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 01:48:04 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 01:48:04 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 01:48:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lUmXLFd2oC/Render', 01:48:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:04 INFO - 'HOME': '/Users/cltbld', 01:48:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:04 INFO - 'LOGNAME': 'cltbld', 01:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:04 INFO - 'MOZ_NO_REMOTE': '1', 01:48:04 INFO - 'NO_EM_RESTART': '1', 01:48:04 INFO - 'PAGER': '/bin/cat', 01:48:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:04 INFO - 'PWD': '/builds/slave/test', 01:48:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:04 INFO - 'SHELL': '/bin/bash', 01:48:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1dq94XUI3Z/Listeners', 01:48:04 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 01:48:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:04 INFO - 'USER': 'cltbld', 01:48:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:04 INFO - 'XPC_FLAGS': '0x0', 01:48:04 INFO - 'XPC_SERVICE_NAME': '0', 01:48:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:48:04 INFO - Cleaning up... 01:48:05 INFO - Return code: 0 01:48:05 INFO - Running post-action listener: _resource_record_post_action 01:48:05 INFO - Running post-action listener: _start_resource_monitoring 01:48:05 INFO - Starting resource monitoring. 01:48:05 INFO - [mozharness: 2016-08-12 08:48:05.034592Z] Finished create-virtualenv step (success) 01:48:05 INFO - [mozharness: 2016-08-12 08:48:05.035600Z] Running install step. 01:48:05 INFO - Running pre-action listener: _resource_record_pre_action 01:48:05 INFO - Running main action method: install 01:48:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:48:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:48:05 INFO - Reading from file tmpfile_stdout 01:48:05 INFO - Detecting whether we're running mozinstall >=1.0... 01:48:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:48:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:48:05 INFO - Reading from file tmpfile_stdout 01:48:05 INFO - Output received: 01:48:05 INFO - Usage: mozinstall [options] installer 01:48:05 INFO - Options: 01:48:05 INFO - -h, --help show this help message and exit 01:48:05 INFO - -d DEST, --destination=DEST 01:48:05 INFO - Directory to install application into. [default: 01:48:05 INFO - "/builds/slave/test"] 01:48:05 INFO - --app=APP Application being installed. [default: firefox] 01:48:05 INFO - mkdir: /builds/slave/test/build/application 01:48:05 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'] 01:48:05 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 01:48:39 INFO - Reading from file tmpfile_stdout 01:48:39 INFO - Output received: 01:48:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:48:39 INFO - Running post-action listener: _resource_record_post_action 01:48:39 INFO - [mozharness: 2016-08-12 08:48:39.551659Z] Finished install step (success) 01:48:39 INFO - [mozharness: 2016-08-12 08:48:39.551781Z] Running run-tests step. 01:48:39 INFO - Running pre-action listener: _resource_record_pre_action 01:48:39 INFO - Running main action method: run_tests 01:48:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:48:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:48:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:48:39 INFO - 2016-08-12 01:48:39.566 screenresolution[1983:10938] starting screenresolution argv=screenresolution get 01:48:39 INFO - 2016-08-12 01:48:39.569 screenresolution[1983:10938] Display 0: 1600x1200x32@60 01:48:39 INFO - 2016-08-12 01:48:39.575 screenresolution[1984:10940] starting screenresolution argv=screenresolution list 01:48:39 INFO - Available Modes on Display 0 01:48:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:48:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:48:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:48:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:48:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:48:39 INFO - Intel Iris: 01:48:39 INFO - Chipset Model: Intel Iris 01:48:39 INFO - Type: GPU 01:48:39 INFO - Bus: Built-In 01:48:39 INFO - VRAM (Dynamic, Max): 1536 MB 01:48:39 INFO - Vendor: Intel (0x8086) 01:48:39 INFO - Device ID: 0x0a2e 01:48:39 INFO - Revision ID: 0x0009 01:48:39 INFO - Displays: 01:48:39 INFO - Display: 01:48:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:48:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:48:39 INFO - Display Serial Number: 1600x1200 60 01:48:39 INFO - Main Display: Yes 01:48:39 INFO - Mirror: Off 01:48:39 INFO - Online: Yes 01:48:39 INFO - Rotation: Supported 01:48:39 INFO - Return code: 0 01:48:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:48:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:48:39 INFO - Python 2.7.3 01:48:39 INFO - Return code: 0 01:48:39 INFO - grabbing minidump binary from tooltool 01:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:48:39 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101068d30>, '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 0x100dcddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101060b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:48:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:48:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 01:48:39 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 01:48:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:48:39 INFO - Return code: 0 01:48:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:48:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:48:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:48:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:48:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:48:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QCojeHmkRmGpUeV3vJV5-w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0321', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:48:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QCojeHmkRmGpUeV3vJV5-w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0321 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:48:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lUmXLFd2oC/Render', 01:48:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:39 INFO - 'HOME': '/Users/cltbld', 01:48:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:39 INFO - 'LOGNAME': 'cltbld', 01:48:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:48:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:48:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:39 INFO - 'MOZ_NO_REMOTE': '1', 01:48:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:48:39 INFO - 'NO_EM_RESTART': '1', 01:48:39 INFO - 'PAGER': '/bin/cat', 01:48:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:39 INFO - 'PWD': '/builds/slave/test', 01:48:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:48:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:39 INFO - 'SHELL': '/bin/bash', 01:48:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1dq94XUI3Z/Listeners', 01:48:39 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 01:48:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:39 INFO - 'USER': 'cltbld', 01:48:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:39 INFO - 'XPC_FLAGS': '0x0', 01:48:39 INFO - 'XPC_SERVICE_NAME': '0', 01:48:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QCojeHmkRmGpUeV3vJV5-w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0321', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:48:40 INFO - mozversion application_buildid: 20160811234715 01:48:40 INFO - mozversion application_changeset: 666549adf9c64d9756bc77319570440e04be7ad7 01:48:40 INFO - mozversion application_display_name: Nightly 01:48:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:48:40 INFO - mozversion application_name: Firefox 01:48:40 INFO - mozversion application_remotingname: firefox 01:48:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:48:40 INFO - mozversion application_vendor: Mozilla 01:48:40 INFO - mozversion application_version: 51.0a1 01:48:40 INFO - mozversion platform_buildid: 20160811234715 01:48:40 INFO - mozversion platform_changeset: 666549adf9c64d9756bc77319570440e04be7ad7 01:48:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:48:40 INFO - mozversion platform_version: 51.0a1 01:48:40 INFO - using testdate: 1470991720 01:48:40 INFO - actual date: 1470991720 01:48:40 INFO - starting webserver on 'localhost:49393' 01:48:40 INFO - SUITE-START | Running 2 tests 01:48:40 INFO - TEST-START | dromaeo_css 01:48:40 INFO - operating with platform_type : mac_ 01:48:40 INFO - Initialising browser for dromaeo_css test... 01:48:40 INFO - TEST-INFO | started process 1994 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpaUo_FW/profile http://localhost:49393/getInfo.html) 01:48:42 INFO - PROCESS | 1994 | __metrics Screen width/height:1600/1200 01:48:42 INFO - PROCESS | 1994 | colorDepth:24 01:48:42 INFO - PROCESS | 1994 | Browser inner width/height: 1024/689 01:48:42 INFO - PROCESS | 1994 | __metrics 01:48:42 INFO - PROCESS | 1994 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:48:42 INFO - PROCESS | 1994 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:48:43 INFO - TEST-INFO | 1994: exit 0 01:48:43 INFO - Browser initialized. 01:48:43 INFO - Running cycle 1/1 for dromaeo_css test... 01:48:43 INFO - TEST-INFO | started process 1996 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpaUo_FW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:48:55 INFO - PROCESS | 1996 | RSS: Main: 243429376 01:48:55 INFO - PROCESS | 1996 | 01:49:46 INFO - PROCESS | 1996 | 1470991786403 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] 01:51:58 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:49393/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49393/tests/dromaeo/cssquery-ext.html) 01:51:59 INFO - PROCESS | 1996 | RSS: Main: 403787776 01:51:59 INFO - PROCESS | 1996 | 01:55:02 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:49393/tests/dromaeo/cssquery-ext.html (next: http://localhost:49393/tests/dromaeo/cssquery-jquery.html) 01:55:03 INFO - PROCESS | 1996 | RSS: Main: 382291968 01:55:03 INFO - PROCESS | 1996 | 01:58:05 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:49393/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49393/tests/dromaeo/cssquery-mootools.html) 01:58:06 INFO - PROCESS | 1996 | RSS: Main: 346193920 01:58:06 INFO - PROCESS | 1996 | 02:01:08 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:49393/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49393/tests/dromaeo/cssquery-prototype.html) 02:01:09 INFO - PROCESS | 1996 | RSS: Main: 352546816 02:01:09 INFO - PROCESS | 1996 | 02:04:12 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:49393/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49393/tests/dromaeo/cssquery-yui.html) 02:04:13 INFO - PROCESS | 1996 | RSS: Main: 338628608 02:04:13 INFO - PROCESS | 1996 | 02:07:17 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:49393/tests/dromaeo/cssquery-yui.html (next: http://localhost:49393/tests/dromaeo/cssquery-dojo.html) 02:07:17 INFO - PROCESS | 1996 | RSS: Main: 443314176 02:07:17 INFO - PROCESS | 1996 | 02:07:17 INFO - PROCESS | 1996 | __start_tp_report 02:07:17 INFO - PROCESS | 1996 | _x_x_mozilla_page_load 02:07:17 INFO - PROCESS | 1996 | _x_x_mozilla_page_load_details 02:07:17 INFO - PROCESS | 1996 | |i|pagename|runs| 02:07:17 INFO - PROCESS | 1996 | |0;dojo.html;3305.884294049708;3320.6015278166624;3335.8665653373864;3345.665433456656;3374.2576633140716;5465.07093794055;5525.143602741577;5598.1602759586085;5611.859703507404;5666.150077488379;5575.303087114111;5596.076647353182;5624.859378515539;5638.126090455976;5644.350899646542;5096.617753668471;5133.897322053556;5157.896842063156;5158.742062896859;5219.947800521984;5187.247849061884;5196.272521846944;5198.168293073109;5198.740062996854;5205.817796377128;5156.20078887773;5173.120569503175;5173.482651734816;5175.870603234912;5193.5325820676135;5229.7385130743505;5240.947590524084;5262.657927234717;5273.868153296198;5316.255724198615;5043.571296439807;5048.7980480780725;5100.846974590768;5147.202183661501;5171.379434467888;5546.833594992157;5557.944420555783;5573.247611572427;5599.832005039855;5621;6169.383061693839;6182.69086545671;6185.814425567195;6189.442950134465;6208.192934918477;6077.118817771443;6084.429671795072;6148.292946311187;6199.101130336121;6243.001119820807;5748.338941021794;5801.187833703285;5834.212381328552;5835.299764028259;5840.474357307863;6291.5281353898645;6293.748250070037;6299.401556852092;6309.7160627770945;6311.0217916223055;5856.882862342729;5923.052311630118;6080.300046138128;6087.634741915499;6091.756329746849;5354.8661283467445;5983.773326468064;6094.235304088532;6158.876822463615;6213.937860621336;5073.771680274396;6098.268207815002;6133.355997620275;6135.171751813448;6139.693015349215;6013.1581578579035;6121.84695382619;6187.226596675416;6195.783147589813;6203.2245969253845;4895.363602731622;4923.48303428142;4929.876753081202;4932.630052746058;4941.258811178352;4433.7561434121435;4459.665525085632;4479.081788233404;4482.910341793146;4482.932756008662;5531.834044978657;5599.300087489064;5606.24315717373;5619;5666.744996475169;6217.564770466114;6231.345708700612;6259.342769009279;6264.9373506265265;6285.560010799291;5517.420670829585;5598.944010559923;5600.551955843604;5604.579656525777;5637.436256374412;5359.839204823861;5421.078416669176;5425.457454254622;5429.538489228381;5434.076207044812;5707.286589176353;5936.910946335808;6264.59280146789;6309.716062777186;6313.55805093639;4992.450830408725;6239.78160764371;6241.157443745036;6257.906131407942;6263.123162757309;6247.687615619292;6275.717592708248;6305.2433707953505;6311.810645680637;6346.809595712136;6152.292486364126;6159.23009623797;6162.322144564184;6169.321374648875;6192.969035154795;6250.937490625036;6255.124282600348;6256.687165641791;6258.937410625836;6274.811755647155;5792.768289268551;5867.9413205867395;5883.235179426647;5964.284285885721;5974.342822289632;5605.943940560543;5873.911891321719;6023;6098.024316109401;6099.969500152648;5927.407259274038;5941.168236446987;5950.553708471795;5970.552208584287;5973.880522389615;6048.516118710405;6087.573869829246;6096.420840020191;6112.8777424452155;6139.877202456015;5747.683877386784;5750.396208398058;5790.334111577223;5842.970785146217;5904.173415721888 02:07:17 INFO - PROCESS | 1996 | |1;ext.html;468.5338088601842;488.728755540675;492.71668790445494;510.14550627698594;525.3931708876249;30953.845230773844;40526.79736601317;41858.16283674325;41951.16097678045;44083.77958110205;42958.14083718332;43429.565704342946;43448.78275608618;43500.91247718809;43553.7822310888;9708.174805141554;9913.157381622535;9913.900860991405;9919.20646348294;9923.702288931343;9648.276379271547;9677.612895484172;9772.120509154174;9790.265730070238;9794.314397992144;9763.75590610237;9807.460589667566;9810.96984816591;9818.50907454628;9838.458884761336;9721.90278097217;9773.267004974585;9803.656872009482;9804.852927206026;9826.361286516354;9737.853932191023;9836.704898853046;9840.26198035143;9840.753981150458;9844.704658860246;40452.19095618071;40716.79641601773;40727.7963610183;40733.185336293405;40767.388489172685;3485.4771784232566;3568.892933211982;3640.4721315409383;3671.229041901204;3905.511811023622;31514.212144696336;31984.200394990312;32828.507572386196;32991.67008329934;33004.17489562756;3262.0866157475707;3263.0700250428513;3297.7032067114073;3301.3727391795483;3328.8335583220983;448452;450652;453155;454310;454901;33170.336593268;58279.708601456725;58590.4140958585;58593.5351616213;58762.118568220656;33737.83131084329;34890.82554587261;35020.29959400798;35297.29405411877;35316.823415882754;14691.485797997018;14904;14925;14930.32813523394;14952.953293269584;12367.567135150226;12413.813792793115;12435.44040518179;12435.75128497425;12440.875591244152;7727.304542591194;7735.381169506426;7808.336291415179;7821.061472623322;7852.84294314122;2745.492083964473;3164.604424446944;3211.951820722691;3211.988223709524;3263.249452625862;934.2245935873209;1021.4280003198232;1072.9248952573246;1073.5276478349658;1103.7406209540752;27519.036833710725;28203.57694634582;29730;30445.847770761004;32720.181995449828;947.5830634520789;1018.6587493189865;1099.082266307626;1131.9943400282946;1134.6142311614092;15658.765118523232;15687.215639217993;15762.605934851721;15875.682486350208;15906.05923861548;661611;665847;668629;669721;670580;58522.70738646365;58982;59038.704806476555;59120.70439647774;59242.66815986582;1237.07219585311;1300.648824817294;1359.9592012239648;1389.9930500347434;1420.3537390487304;24097.879510603037;29377;31208;31445.842770786;31841.840790795897;50426.49573504218;51162.488375115776;51256.23115653193;51271;51282.23076653779;567726;571338;571387;572091;572925;23061.88469057644;25888.8705556471;26170.476590468465;26467.470650586496;26564;47900.520994791;48343;48642.81107350107;49060.509394905595;50318.24522632237;40048.79975600103;40206;40427;40848.89388826397;41485.1702965945;33295;40021.39967900426;40165.79917100396;40401.595984039785;41358;31247.906323278577;33651.66348336583;34202.657973420944;39588.60411395849;39765.60234397619;29171.85414073001;34669.65330346664;35260.64739352574;35584.82207588945;35766.46350304696;25513;25562.744372556037;25619;25696.87151564305;26405.867970660023 02:07:17 INFO - PROCESS | 1996 | |2;jquery.html;319.65956256586736;353.9716822654188;371.9181780008399;377.28504484002815;405.5457887166374;14998.875084368676;17524.649507009854;21146;21301.573968520657;21406.785932140672;18089.005104719236;18552.814471855276;18576.721349179774;19987.900060499676;20918.581628367425;5378.408375078739;5844.853878653036;6096.573239873211;6098.359672234418;6106.816795496142;5918.526517878559;6098.390160983889;6101.35935726749;6109.450149486545;6118.632882027093;5851.356350801409;6050.304215015263;6051.243594550681;6054.6367217966845;6162.938370616282;6163.044728067134;6208.627482351051;6212.130301757735;6212.9068063979075;6220.657863817488;5784.913226301609;5988.880222395528;6043.244594425697;6045.848853778647;6059.606125601866;13313.933430332883;13573.59279221625;14849.406023759037;26325.81533830982;26648.60027099595;1959.6374670685825;2483.3915690655726;2663.4007348346468;2707.891684332624;3011.412774508972;10045.69862904114;10101.19190464761;10475.371477711362;10498.475076246157;10506.789864202674;1799.8470130038963;1804.0709034846934;1832.7800663920416;1845.7877344105466;1875.3248830421037;114724.42637786841;121831;122892;123102;124576;11302.547898083985;11620.709482263012;11627.825582616268;11638.301701897914;11815.995640370493;14419.567412977627;14440.350184241734;14449.78325325121;14449.85550144485;14470.20413877247;7094.326039026284;8343.624536895853;8547.957260213783;8602.225799678059;8754.47473151613;6932.549384290005;8515.74452766418;8525.693871942856;8655.17775811297;8882.689105881263;4413.426254586947;4458.331250312414;4477.149341625146;4580.885477863014;4587.4036375271;1571.8035245594301;1754.5349633056285;1820.8088150744245;1918.6930091185623;1927.6144771045847;834.586879494654;853.3642436384808;1004.1414590525142;1011.6661501704419;1037.4812593703148;21011.264605738725;21344.252951146635;21549;21593.568128637653;21750.89124554367;805.8227190018187;852.3905407633572;925.153484561632;943.0475220027685;949.378157306965;10920.617778377718;11368.374739389248;11432.256903301259;11435.371054592077;11446.942765286287;588276;601007;605294;608992;609063;119948.00389970787;130201;130691;130746;131175.7206069856;948.7296120605595;967.7000129959735;981.3032746749744;986.1568359052907;988.0712130597359;15093.849061509245;18155;19903.800961990193;19962.500937476678;19991.500212494804;50258.24096156763;56949.430505694414;57241;58691.826163477344;58706.706466467396;62220.37779622146;75946.24053759391;77582.2241777575;77706;78512.60743696245;7991.120976692676;8091.069527004234;8249.83500329978;8326.83346333082;8336.374771892253;12661.556845510731;12840.550580730003;13150.868491314965;13633.113847599874;13868.306584670525;11506.13515174372;11963.342016189194;11966.9828064612;12022.27866328023;12060.155789094679;11325.32048077085;11414.201005929504;11656.242344247597;11888.76222475563;11949.940250299042;11281.943590281997;11702.70743231392;11919.582814601446;12037.337946412681;12148.817767733668;6931.133608298963;7138.928610713826;7324.450666199949;7998.40011999114;8568.657253709782;11041.951014653596;11349.602763903224;11722.88277117252;11829.408529573659;11841.703957401134 02:07:17 INFO - PROCESS | 1996 | |3;mootools.html;1494.2976800903575;1535.1633359818898;1696.3892998520523;1715.4682048564946;1828.1499102917141;7014.368706816385;8080.232377924088;8239.588020598969;8605.483670979746;8781.604827782749;8367.916320836805;8626.137386261371;8637.006744224416;8730.476171429718;8735.606897689604;2301.620232661609;2326.499802542453;2332.323626148415;2339.7075365579303;2345.7654234576576;2063.515073957619;2143.871367717934;2288.2220045184636;2321.570509455756;2343.7304709958316;2276.4991701825656;2352.1532248390567;2353.788159065684;2356;2356;2313.8958746856265;2337.6493525971155;2341.630146364379;2345.7419683834764;2348.072511358021;2317.9304620861403;2336.380859072347;2337.135259953828;2346.7301260355107;2354.21133920137;8707.259882909897;8778.990416102166;8780.824383512358;8791.824163516758;8798.252148567379;5129.0767661820855;5181;5253.474652534755;5257.369115706101;5259.815906443295;3293.275479394529;3446.4313388290902;3492.14442461596;3554.253606742587;3561.82190890457;1021.0657248617506;1051.1905832509;1051.9789604207872;1067.1942683274156;1075.8601381820313;11458.598949036743;11524.078073754079;11545.365004924726;11552.480138393792;11564.95915367621;3761.605031471711;4456.532064133284;4757.26262429324;4759.0719809636785;4770.522947705202;9828.066333698287;9830;9837.655682051094;9844.015598440099;9872.111509964137;5302.072137376021;5302.2046692996355;5304.045271851027;5305.124654432053;5322.654027488278;4757.643176761757;4789.688670236424;4865.172920603506;4871.464138944713;4876.512348765095;3876.573576906538;3882.7282090253975;3913.373860182357;3966.5835087315995;4039.030632648143;1176.499987505324;1209.5887398284626;1235.857876344214;1264.5890085722176;1268.822364868919;817.235884448043;907.2107266678032;916.8349697054595;922.3635691372931;931.2968708625081;4751.358566593535;5750.712464376765;6092.543059270483;6132.356102609251;6174.722137503823;803.9115697273295;954.6038394066385;955.6129767444196;960.4957397366438;991.038692468319;4016.4577781999055;4026.879193624196;4070.7964601769795;4145.233131870614;4148.979255103705;10265.846012309821;10642.946785266178;10645.520951557199;10656;10666.413347265974;10028.197744180448;10474.581016759397;10494.055535001886;10531.684049478528;10621;7971.641276142587;8167.714130005421;8188.426810123353;8209.220124088082;8210.671573137008;5226.45122262157;5435.93999170158;5798.391168927202;6025.126356678345;6253.593516421418;9715.979822118576;9854;9992.250581206294;10014.549345279334;10022.799544008933;9931;10037.49812509357;10130.138938190335;10133.746656333651;10151.390916545031;7454.739084132029;7598.96200519016;7616.961915190389;7618.733344332922;7627.885581716389;8086.676532938616;8107.959460202661;8181.5500147490075;8237.588120593826;8281;6083.7870674526175;7427.294407031323;7473.9379271354255;7535.133459651991;7570.05374328209;7289.8177545559665;7355.2277010913085;7362.926370736224;7373.815654608463;7414.592197428978;6959.965200173967;6961.512694111364;6990.196127445409;7032.367086962198;7051.964740176266;4595.287730401793;4635.745034023161;4875.585575226004;5038.722870242172;5182.352205974254;4601.33280674307;4923.359963204761;4940.654154209171;5007.474215207497;5215.843524694265 02:07:17 INFO - PROCESS | 1996 | |4;prototype.html;296.4663605510082;297.510595071108;308.77922285565825;314.1846907275619;318.1283283802382;4480;5353.464653534645;5381.461853814617;5414.779940224504;5439.401665816767;4637.118947399992;4956.504349565042;5081.568066714333;5173.723561632879;5355.892882142355;3627.2745450909792;4088.8568900088503;4090.754554726711;4098.405731168971;4111.71218014739;3402.489626556024;4018.4775979122674;4117.588241175873;4129.339305711087;4159.188958153161;3271.5910511186103;4021.5777343378963;4035.919281614366;4089.3457046872504;4110.321796903522;3545.663161999606;4040.696947728932;4047.797610119482;4048.271311163989;4062.4921884764403;3494.2836718472904;3496.4056110461283;3501.28223714138;3517.7009954153928;3531.993381886176;4732.550407711262;4933.827316043958;5142.794288228466;5221.686698798084;5258.158694608845;3688.981555092207;4217.873463796061;4654.348391225231;4659.4408670959365;4784.856454306341;5604.243427137325;5618.381977982419;5641.464060914206;5662.886742265173;5677.489025987681;3861.9876496332904;3871.032241939515;3871.361225397806;3882.611738826123;3891.20230352777;5585.078462053756;5856.32652244993;5900.957843876958;5938.25771778532;5988.640681559077;3284.540164376989;3911.8239679214503;3932.3708206686792;3939.940900886489;4002.419649150915;3958.4853968984426;3980.2238563479846;3998.7400818946676;4011.2579172853116;4017.879463616096;3719.6466335698065;4290.206311832321;4327.004788898571;4464.352668862996;4662.836800711959;4667.883302917387;4956.4547899731;5677.744501497443;5725.685087320154;5747.7413516391025;1286.9511348251333;1338.692100816798;1353.729254149174;1374.3471850870956;1377.3801789194902;840.9663613455516;876.9473831569999;896.9282457403392;904.3946994085419;909.5861383070819;5089.51649593288;5113.539781419616;5113.769880355393;5141.71720555373;5149.845504634867;5419.701916394557;5665.065264231438;5713.628614140151;5720.68536230503;5746.276117164917;4666.903277729731;4791.377120974251;4832.173178690506;5061.937527795631;5132.974335128375;2844.687084420712;2959.393324368499;2992.6558445779015;2993.3863557970562;3002.0523012238837;4924.409070911442;5528.336599607992;5788.652680839163;5850.3564607893095;5857.384974577693;4917.852464426073;4991.80032798684;5738.368779434259;5771.797987070517;5823;4450.866474005785;5125.462361291523;5831.88336233273;5833.833233353346;5873.823785286449;5372.892542149213;5421.888512854935;5442.775375540472;5588.692621905671;5675.9499492594005;5181.844544663666;5585.860353491195;5589.211452335214;5596.524295434933;5602.5517958562405;5332.813351532678;5583.274174357308;5802.4894938561565;5814;5862.186150647628;3755.7934313611922;3817.809109544456;3823.4456003878727;3828.5214348206473;3838.5201849768778;4665.300204969146;5584.274044374205;5610.689693081102;5626.803061892814;5637.915431268616;4314.71954322968;4611.123886461562;4822.397200349957;5511.263951855153;5517.48269225966;4728.503507131702;5339.78640854377;5462.781488740406;5465.808696695596;5477.452254774491;5028.472010438852;5159.432462429205;5357.098230128248;5371.328583927009;5474.288342515607;4756.9048619026735;4841.878953026203;5700.543956483389;5707.343655479507;5743.396943320891;4740.3882679889;5554.555635549065;5587.55299576041;5589.031787430969;5607.186957891165 02:07:17 INFO - PROCESS | 1996 | |5;yui.html;699.4439420660574;726.6512074204381;760.4600733479231;776.2586729673162;810.1627771903436;15226.314815833286;15754.054756714591;16850.49448516545;16887;16887.915560422196;14082.295885205749;15239.085654860688;15250.923745381286;15283.694326113471;15303.234838258099;684.4797953555284;693.9278814231999;709.684190535212;828.1511450762956;863.6372723456132;849.371465115816;856.3235044314983;860.7417774667574;860.7718954477068;861.1259571534897;916.6241840845255;918.0589895357278;918.7703074231442;919.1773362840254;921.7188757428981;908.0556221529667;908.6774195160722;909.4997751236859;909.8544232922734;910.3718434280391;531.8537402214383;564.3087218157765;654.6006935769177;666.2072134160334;677.6036018928933;15549.30028148736;15613.609659758484;15617.765733514007;15624.843751562452;15648;13930.303484825718;14357.353919073666;14545.27273636314;14547.563573092824;14609.926950365287;12803.80794288077;12845.229286242855;13069.934650326783;13191;13557.728845423135;4540.682152249344;4576.565226303496;4599.103174880899;4663.790129444149;4743.905121897543;111849.88150118476;112780;113029.43485282603;115332.4233378836;123602.76397236003;11241.55033798639;11379.54481820718;11463.140264480196;11464.54141834334;11954.940225298818;23364.53270934606;23383.88308058449;23402.64896026561;23405.063797448252;23411.063557457852;8025.23760242776;8188.795280117925;8241.670333186605;8291.668333266602;8396.118407567117;3924.646781789653;4334.631556317685;4337.652987760972;4351;4643.907121857612;3467.4625433057918;3584.372734771405;3585.1933315004435;3589.210373717778;3589.7307701921936;630.2489632753001;636.8821767972939;652.3281020548842;655.8589903170841;659.8749132728782;537.6370949608998;596.9194158788508;611.703323887914;624.4536030972898;636.5575924732267;9007.77480562978;9085.954570227106;9193.724188274362;9221.216196623229;9307.627694892128;581.1697035437446;632.844952986512;636.6275728698671;638.8339031851659;640.5496648747164;3649.9464264454705;4259.61663450291;4357;4401.185780630593;4408.603225709701;101991.47012794814;142144;164265;168088.15955920142;170767.14616426837;98773.50613246887;113620;114814.42592786983;147337;151228.24385878;104324;104396.08237217604;112684.73152684829;114769.4261528687;116528;7499.137599176164;9661.420314781135;9726.36778609388;9796.069373409515;10019.298649094493;64137;64376;65024.37439064061;66018.66990665016;67159.66420167868;93504.12991740264;95559.41083776244;96976;99647;99669;9370.906290937004;10702.357858528514;11403.942980285046;11444.656660300205;13294.867051329364;12850.67873303175;12925.547605834126;13333.133346332457;13361.398737056661;14468.27658617086;11015.339079655247;11819.468123934616;13448.596542103362;13587.116837405538;14097.295135243401;13516.189028658311;14063.789043164155;14209.715805684034;14693.779593306323;15067.623309417353;11071.944640276746;12396.822301881306;13393.330333483482;13663.316834158451;13781.931090344886;10482.895171048192;10928.890711092787;11588.594399195988;11620.418979051183;11881.5841445549;9631.951840240754;11458.598949036743;11522.711932201762;11796.29222246668;11845.348505832262 02:07:17 INFO - PROCESS | 1996 | __end_tp_report 02:07:17 INFO - PROCESS | 1996 | __start_cc_report 02:07:17 INFO - PROCESS | 1996 | _x_x_mozilla_cycle_collect,1534 02:07:17 INFO - PROCESS | 1996 | __end_cc_report 02:07:17 INFO - PROCESS | 1996 | __startTimestamp1470992837290__endTimestamp 02:07:17 INFO - PROCESS | 1996 | 02:07:17 INFO - PROCESS | 1996 | ------- Summary: start ------- 02:07:17 INFO - PROCESS | 1996 | Number of tests: 6 02:07:17 INFO - PROCESS | 1996 | 02:07:17 INFO - PROCESS | 1996 | [#0] dojo.html Cycles:165 Average:5674.38 Median:5835.30 stddev:626.35 (10.7%) stddev-sans-first:600.08 02:07:17 INFO - PROCESS | 1996 | Values: 3305.9 3320.6 3335.9 3345.7 3374.3 5465.1 5525.1 5598.2 5611.9 5666.2 5575.3 5596.1 5624.9 5638.1 5644.4 5096.6 5133.9 5157.9 5158.7 5219.9 5187.2 5196.3 5198.2 5198.7 5205.8 5156.2 5173.1 5173.5 5175.9 5193.5 5229.7 5240.9 5262.7 5273.9 5316.3 5043.6 5048.8 5100.8 5147.2 5171.4 5546.8 5557.9 5573.2 5599.8 5621.0 6169.4 6182.7 6185.8 6189.4 6208.2 6077.1 6084.4 6148.3 6199.1 6243.0 5748.3 5801.2 5834.2 5835.3 5840.5 6291.5 6293.7 6299.4 6309.7 6311.0 5856.9 5923.1 6080.3 6087.6 6091.8 5354.9 5983.8 6094.2 6158.9 6213.9 5073.8 6098.3 6133.4 6135.2 6139.7 6013.2 6121.8 6187.2 6195.8 6203.2 4895.4 4923.5 4929.9 4932.6 4941.3 4433.8 4459.7 4479.1 4482.9 4482.9 5531.8 5599.3 5606.2 5619.0 5666.7 6217.6 6231.3 6259.3 6264.9 6285.6 5517.4 5598.9 5600.6 5604.6 5637.4 5359.8 5421.1 5425.5 5429.5 5434.1 5707.3 5936.9 6264.6 6309.7 6313.6 4992.5 6239.8 6241.2 6257.9 6263.1 6247.7 6275.7 6305.2 6311.8 6346.8 6152.3 6159.2 6162.3 6169.3 6193.0 6250.9 6255.1 6256.7 6258.9 6274.8 5792.8 5867.9 5883.2 5964.3 5974.3 5605.9 5873.9 6023.0 6098.0 6100.0 5927.4 5941.2 5950.6 5970.6 5973.9 6048.5 6087.6 6096.4 6112.9 6139.9 5747.7 5750.4 5790.3 5843.0 5904.2 02:07:17 INFO - PROCESS | 1996 | 02:07:17 INFO - PROCESS | 1996 | [#1] ext.html Cycles:180 Average:68565.35 Median:40414.30 stddev:152771.61 (378.0%) stddev-sans-first:153114.62 02:07:17 INFO - PROCESS | 1996 | Values: 468.5 488.7 492.7 510.1 525.4 30953.8 40526.8 41858.2 41951.2 44083.8 42958.1 43429.6 43448.8 43500.9 43553.8 9708.2 9913.2 9913.9 9919.2 9923.7 9648.3 9677.6 9772.1 9790.3 9794.3 9763.8 9807.5 9811.0 9818.5 9838.5 9721.9 9773.3 9803.7 9804.9 9826.4 9737.9 9836.7 9840.3 9840.8 9844.7 40452.2 40716.8 40727.8 40733.2 40767.4 3485.5 3568.9 3640.5 3671.2 3905.5 31514.2 31984.2 32828.5 32991.7 33004.2 3262.1 3263.1 3297.7 3301.4 3328.8 448452.0 450652.0 453155.0 454310.0 454901.0 33170.3 58279.7 58590.4 58593.5 58762.1 33737.8 34890.8 35020.3 35297.3 35316.8 14691.5 14904.0 14925.0 14930.3 14953.0 12367.6 12413.8 12435.4 12435.8 12440.9 7727.3 7735.4 7808.3 7821.1 7852.8 2745.5 3164.6 3212.0 3212.0 3263.2 934.2 1021.4 1072.9 1073.5 1103.7 27519.0 28203.6 29730.0 30445.8 32720.2 947.6 1018.7 1099.1 1132.0 1134.6 15658.8 15687.2 15762.6 15875.7 15906.1 661611.0 665847.0 668629.0 669721.0 670580.0 58522.7 58982.0 59038.7 59120.7 59242.7 1237.1 1300.6 1360.0 1390.0 1420.4 24097.9 29377.0 31208.0 31445.8 31841.8 50426.5 51162.5 51256.2 51271.0 51282.2 567726.0 571338.0 571387.0 572091.0 572925.0 23061.9 25888.9 26170.5 26467.5 26564.0 47900.5 48343.0 48642.8 49060.5 50318.2 40048.8 40206.0 40427.0 40848.9 41485.2 33295.0 40021.4 40165.8 40401.6 41358.0 31247.9 33651.7 34202.7 39588.6 39765.6 29171.9 34669.7 35260.6 35584.8 35766.5 25513.0 25562.7 25619.0 25696.9 26405.9 02:07:17 INFO - PROCESS | 1996 | 02:07:17 INFO - PROCESS | 1996 | [#2] jquery.html Cycles:180 Average:35140.88 Median:21672.23 stddev:100618.87 (464.3%) stddev-sans-first:100867.16 02:07:17 INFO - PROCESS | 1996 | Values: 319.7 354.0 371.9 377.3 405.5 14998.9 17524.6 21146.0 21301.6 21406.8 18089.0 18552.8 18576.7 19987.9 20918.6 5378.4 5844.9 6096.6 6098.4 6106.8 5918.5 6098.4 6101.4 6109.5 6118.6 5851.4 6050.3 6051.2 6054.6 6162.9 6163.0 6208.6 6212.1 6212.9 6220.7 5784.9 5988.9 6043.2 6045.8 6059.6 13313.9 13573.6 14849.4 26325.8 26648.6 1959.6 2483.4 2663.4 2707.9 3011.4 10045.7 10101.2 10475.4 10498.5 10506.8 1799.8 1804.1 1832.8 1845.8 1875.3 114724.4 121831.0 122892.0 123102.0 124576.0 11302.5 11620.7 11627.8 11638.3 11816.0 14419.6 14440.4 14449.8 14449.9 14470.2 7094.3 8343.6 8548.0 8602.2 8754.5 6932.5 8515.7 8525.7 8655.2 8882.7 4413.4 4458.3 4477.1 4580.9 4587.4 1571.8 1754.5 1820.8 1918.7 1927.6 834.6 853.4 1004.1 1011.7 1037.5 21011.3 21344.3 21549.0 21593.6 21750.9 805.8 852.4 925.2 943.0 949.4 10920.6 11368.4 11432.3 11435.4 11446.9 588276.0 601007.0 605294.0 608992.0 609063.0 119948.0 130201.0 130691.0 130746.0 131175.7 948.7 967.7 981.3 986.2 988.1 15093.8 18155.0 19903.8 19962.5 19991.5 50258.2 56949.4 57241.0 58691.8 58706.7 62220.4 75946.2 77582.2 77706.0 78512.6 7991.1 8091.1 8249.8 8326.8 8336.4 12661.6 12840.6 13150.9 13633.1 13868.3 11506.1 11963.3 11967.0 12022.3 12060.2 11325.3 11414.2 11656.2 11888.8 11949.9 11281.9 11702.7 11919.6 12037.3 12148.8 6931.1 7138.9 7324.5 7998.4 8568.7 11042.0 11349.6 11722.9 11829.4 11841.7 02:07:17 INFO - PROCESS | 1996 | 02:07:17 INFO - PROCESS | 1996 | [#3] mootools.html Cycles:180 Average:5650.51 Median:4899.94 stddev:3160.76 (64.5%) stddev-sans-first:3154.19 02:07:17 INFO - PROCESS | 1996 | Values: 1494.3 1535.2 1696.4 1715.5 1828.1 7014.4 8080.2 8239.6 8605.5 8781.6 8367.9 8626.1 8637.0 8730.5 8735.6 2301.6 2326.5 2332.3 2339.7 2345.8 2063.5 2143.9 2288.2 2321.6 2343.7 2276.5 2352.2 2353.8 2356.0 2356.0 2313.9 2337.6 2341.6 2345.7 2348.1 2317.9 2336.4 2337.1 2346.7 2354.2 8707.3 8779.0 8780.8 8791.8 8798.3 5129.1 5181.0 5253.5 5257.4 5259.8 3293.3 3446.4 3492.1 3554.3 3561.8 1021.1 1051.2 1052.0 1067.2 1075.9 11458.6 11524.1 11545.4 11552.5 11565.0 3761.6 4456.5 4757.3 4759.1 4770.5 9828.1 9830.0 9837.7 9844.0 9872.1 5302.1 5302.2 5304.0 5305.1 5322.7 4757.6 4789.7 4865.2 4871.5 4876.5 3876.6 3882.7 3913.4 3966.6 4039.0 1176.5 1209.6 1235.9 1264.6 1268.8 817.2 907.2 916.8 922.4 931.3 4751.4 5750.7 6092.5 6132.4 6174.7 803.9 954.6 955.6 960.5 991.0 4016.5 4026.9 4070.8 4145.2 4149.0 10265.8 10642.9 10645.5 10656.0 10666.4 10028.2 10474.6 10494.1 10531.7 10621.0 7971.6 8167.7 8188.4 8209.2 8210.7 5226.5 5435.9 5798.4 6025.1 6253.6 9716.0 9854.0 9992.3 10014.5 10022.8 9931.0 10037.5 10130.1 10133.7 10151.4 7454.7 7599.0 7617.0 7618.7 7627.9 8086.7 8108.0 8181.6 8237.6 8281.0 6083.8 7427.3 7473.9 7535.1 7570.1 7289.8 7355.2 7362.9 7373.8 7414.6 6960.0 6961.5 6990.2 7032.4 7052.0 4595.3 4635.7 4875.6 5038.7 5182.4 4601.3 4923.4 4940.7 5007.5 5215.8 02:07:17 INFO - PROCESS | 1996 | 02:07:17 INFO - PROCESS | 1996 | [#4] prototype.html Cycles:180 Average:4492.35 Median:4974.15 stddev:1362.27 (27.4%) stddev-sans-first:1329.19 02:07:17 INFO - PROCESS | 1996 | Values: 296.5 297.5 308.8 314.2 318.1 4480.0 5353.5 5381.5 5414.8 5439.4 4637.1 4956.5 5081.6 5173.7 5355.9 3627.3 4088.9 4090.8 4098.4 4111.7 3402.5 4018.5 4117.6 4129.3 4159.2 3271.6 4021.6 4035.9 4089.3 4110.3 3545.7 4040.7 4047.8 4048.3 4062.5 3494.3 3496.4 3501.3 3517.7 3532.0 4732.6 4933.8 5142.8 5221.7 5258.2 3689.0 4217.9 4654.3 4659.4 4784.9 5604.2 5618.4 5641.5 5662.9 5677.5 3862.0 3871.0 3871.4 3882.6 3891.2 5585.1 5856.3 5901.0 5938.3 5988.6 3284.5 3911.8 3932.4 3939.9 4002.4 3958.5 3980.2 3998.7 4011.3 4017.9 3719.6 4290.2 4327.0 4464.4 4662.8 4667.9 4956.5 5677.7 5725.7 5747.7 1287.0 1338.7 1353.7 1374.3 1377.4 841.0 876.9 896.9 904.4 909.6 5089.5 5113.5 5113.8 5141.7 5149.8 5419.7 5665.1 5713.6 5720.7 5746.3 4666.9 4791.4 4832.2 5061.9 5133.0 2844.7 2959.4 2992.7 2993.4 3002.1 4924.4 5528.3 5788.7 5850.4 5857.4 4917.9 4991.8 5738.4 5771.8 5823.0 4450.9 5125.5 5831.9 5833.8 5873.8 5372.9 5421.9 5442.8 5588.7 5675.9 5181.8 5585.9 5589.2 5596.5 5602.6 5332.8 5583.3 5802.5 5814.0 5862.2 3755.8 3817.8 3823.4 3828.5 3838.5 4665.3 5584.3 5610.7 5626.8 5637.9 4314.7 4611.1 4822.4 5511.3 5517.5 4728.5 5339.8 5462.8 5465.8 5477.5 5028.5 5159.4 5357.1 5371.3 5474.3 4756.9 4841.9 5700.5 5707.3 5743.4 4740.4 5554.6 5587.6 5589.0 5607.2 02:07:17 INFO - PROCESS | 1996 | 02:07:17 INFO - PROCESS | 1996 | [#5] yui.html Cycles:180 Average:25264.46 Median:3587.20 stddev:40451.51 (1127.7%) stddev-sans-first:40522.94 02:07:17 INFO - PROCESS | 1996 | Values: 699.4 726.7 760.5 776.3 810.2 15226.3 15754.1 16850.5 16887.0 16887.9 14082.3 15239.1 15250.9 15283.7 15303.2 684.5 693.9 709.7 828.2 863.6 849.4 856.3 860.7 860.8 861.1 916.6 918.1 918.8 919.2 921.7 908.1 908.7 909.5 909.9 910.4 531.9 564.3 654.6 666.2 677.6 15549.3 15613.6 15617.8 15624.8 15648.0 13930.3 14357.4 14545.3 14547.6 14609.9 12803.8 12845.2 13069.9 13191.0 13557.7 4540.7 4576.6 4599.1 4663.8 4743.9 111849.9 112780.0 113029.4 115332.4 123602.8 11241.6 11379.5 11463.1 11464.5 11954.9 23364.5 23383.9 23402.6 23405.1 23411.1 8025.2 8188.8 8241.7 8291.7 8396.1 3924.6 4334.6 4337.7 4351.0 4643.9 3467.5 3584.4 3585.2 3589.2 3589.7 630.2 636.9 652.3 655.9 659.9 537.6 596.9 611.7 624.5 636.6 9007.8 9086.0 9193.7 9221.2 9307.6 581.2 632.8 636.6 638.8 640.5 3649.9 4259.6 4357.0 4401.2 4408.6 101991.5 142144.0 164265.0 168088.2 170767.1 98773.5 113620.0 114814.4 147337.0 151228.2 104324.0 104396.1 112684.7 114769.4 116528.0 7499.1 9661.4 9726.4 9796.1 10019.3 64137.0 64376.0 65024.4 66018.7 67159.7 93504.1 95559.4 96976.0 99647.0 99669.0 9370.9 10702.4 11403.9 11444.7 13294.9 12850.7 12925.5 13333.1 13361.4 14468.3 11015.3 11819.5 13448.6 13587.1 14097.3 13516.2 14063.8 14209.7 14693.8 15067.6 11071.9 12396.8 13393.3 13663.3 13781.9 10482.9 10928.9 11588.6 11620.4 11881.6 9632.0 11458.6 11522.7 11796.3 11845.3 02:07:17 INFO - PROCESS | 1996 | -------- Summary: end -------- 02:07:17 INFO - PROCESS | 1996 | 02:07:17 INFO - TEST-INFO | 1996: exit 0 02:07:17 INFO - TEST-OK | dromaeo_css | took 1117773ms 02:07:17 INFO - TEST-START | kraken 02:07:17 INFO - operating with platform_type : mac_ 02:07:17 INFO - Initialising browser for kraken test... 02:07:17 INFO - TEST-INFO | started process 1999 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmp0AGIzB/profile http://localhost:49393/getInfo.html) 02:07:20 INFO - PROCESS | 1999 | __metrics Screen width/height:1600/1200 02:07:20 INFO - PROCESS | 1999 | colorDepth:24 02:07:20 INFO - PROCESS | 1999 | Browser inner width/height: 1024/689 02:07:20 INFO - PROCESS | 1999 | __metrics 02:07:20 INFO - PROCESS | 1999 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:07:20 INFO - PROCESS | 1999 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:07:21 INFO - TEST-INFO | 1999: exit 0 02:07:21 INFO - Browser initialized. 02:07:21 INFO - Running cycle 1/1 for kraken test... 02:07:21 INFO - TEST-INFO | started process 2000 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmp0AGIzB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:07:33 INFO - PROCESS | 2000 | RSS: Main: 243478528 02:07:33 INFO - PROCESS | 2000 | 02:07:36 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49393/tests/kraken/driver.html?testName=audio-beat-detection) 02:07:36 INFO - PROCESS | 2000 | RSS: Main: 293494784 02:07:36 INFO - PROCESS | 2000 | 02:07:39 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49393/tests/kraken/driver.html?testName=audio-dft) 02:07:40 INFO - PROCESS | 2000 | RSS: Main: 300138496 02:07:40 INFO - PROCESS | 2000 | 02:07:43 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49393/tests/kraken/driver.html?testName=audio-fft) 02:07:44 INFO - PROCESS | 2000 | RSS: Main: 394506240 02:07:44 INFO - PROCESS | 2000 | 02:07:46 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49393/tests/kraken/driver.html?testName=audio-oscillator) 02:07:47 INFO - PROCESS | 2000 | RSS: Main: 296955904 02:07:47 INFO - PROCESS | 2000 | 02:07:49 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49393/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:07:49 INFO - PROCESS | 2000 | RSS: Main: 302161920 02:07:49 INFO - PROCESS | 2000 | 02:07:52 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49393/tests/kraken/driver.html?testName=imaging-darkroom) 02:07:53 INFO - PROCESS | 2000 | RSS: Main: 337063936 02:07:53 INFO - PROCESS | 2000 | 02:07:56 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49393/tests/kraken/driver.html?testName=imaging-desaturate) 02:07:56 INFO - PROCESS | 2000 | RSS: Main: 338984960 02:07:56 INFO - PROCESS | 2000 | 02:07:59 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49393/tests/kraken/driver.html?testName=json-parse-financial) 02:08:00 INFO - PROCESS | 2000 | RSS: Main: 339476480 02:08:00 INFO - PROCESS | 2000 | 02:08:01 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49393/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:08:02 INFO - PROCESS | 2000 | RSS: Main: 314347520 02:08:02 INFO - PROCESS | 2000 | 02:08:04 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49393/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:08:05 INFO - PROCESS | 2000 | RSS: Main: 320032768 02:08:05 INFO - PROCESS | 2000 | 02:08:07 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49393/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:08:08 INFO - PROCESS | 2000 | RSS: Main: 327139328 02:08:08 INFO - PROCESS | 2000 | 02:08:10 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49393/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:08:11 INFO - PROCESS | 2000 | RSS: Main: 328716288 02:08:11 INFO - PROCESS | 2000 | 02:08:14 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49393/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:08:15 INFO - PROCESS | 2000 | RSS: Main: 330125312 02:08:15 INFO - PROCESS | 2000 | 02:08:16 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49393/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49393/tests/kraken/driver.html?testName=ai-astar) 02:08:16 INFO - PROCESS | 2000 | RSS: Main: 373497856 02:08:16 INFO - PROCESS | 2000 | 02:08:16 INFO - PROCESS | 2000 | __start_tp_report 02:08:16 INFO - PROCESS | 2000 | _x_x_mozilla_page_load 02:08:16 INFO - PROCESS | 2000 | _x_x_mozilla_page_load_details 02:08:16 INFO - PROCESS | 2000 | |i|pagename|runs| 02:08:16 INFO - PROCESS | 2000 | |0;ai-astar;103;114;114;114;113;115;113;112;113;113 02:08:16 INFO - PROCESS | 2000 | |1;audio-beat-detection;145;108;104;171;109;104;128;105;141;106 02:08:16 INFO - PROCESS | 2000 | |2;audio-dft;181;183;185;188;183;184;183;182;178;183 02:08:16 INFO - PROCESS | 2000 | |3;audio-fft;78;60;74;115;83;82;70;56;101;57 02:08:16 INFO - PROCESS | 2000 | |4;audio-oscillator;93;69;130;102;110;68;98;70;69;129 02:08:16 INFO - PROCESS | 2000 | |5;imaging-gaussian-blur;90;87;90;87;89;85;89;87;89;95 02:08:16 INFO - PROCESS | 2000 | |6;imaging-darkroom;93;94;94;94;93;94;97;94;94;94 02:08:16 INFO - PROCESS | 2000 | |7;imaging-desaturate;84;86;84;88;83;104;134;134;84;83 02:08:16 INFO - PROCESS | 2000 | |8;json-parse-financial;54;53;52;53;53;55;53;53;55;52 02:08:16 INFO - PROCESS | 2000 | |9;json-stringify-tinderbox;66;76;76;75;78;71;73;72;74;73 02:08:16 INFO - PROCESS | 2000 | |10;stanford-crypto-aes;83;86;83;84;84;83;81;86;85;86 02:08:16 INFO - PROCESS | 2000 | |11;stanford-crypto-ccm;137;137;133;136;142;146;150;141;156;137 02:08:16 INFO - PROCESS | 2000 | |12;stanford-crypto-pbkdf2;170;168;192;212;165;167;166;166;165;166 02:08:16 INFO - PROCESS | 2000 | |13;stanford-crypto-sha256-iterative;66;66;67;67;66;66;66;65;66;65 02:08:16 INFO - PROCESS | 2000 | __end_tp_report 02:08:16 INFO - PROCESS | 2000 | __start_cc_report 02:08:16 INFO - PROCESS | 2000 | _x_x_mozilla_cycle_collect,2099 02:08:16 INFO - PROCESS | 2000 | __end_cc_report 02:08:16 INFO - PROCESS | 2000 | __startTimestamp1470992896955__endTimestamp 02:08:16 INFO - PROCESS | 2000 | 02:08:16 INFO - PROCESS | 2000 | ------- Summary: start ------- 02:08:16 INFO - PROCESS | 2000 | Number of tests: 14 02:08:16 INFO - PROCESS | 2000 | 02:08:16 INFO - PROCESS | 2000 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.50 stddev:3.41 (3.0%) stddev-sans-first:0.88 02:08:16 INFO - PROCESS | 2000 | Values: 103.0 114.0 114.0 114.0 113.0 115.0 113.0 112.0 113.0 113.0 02:08:16 INFO - PROCESS | 2000 | 02:08:16 INFO - PROCESS | 2000 | [#1] audio-beat-detection Cycles:10 Average:122.10 Median:118.50 stddev:23.30 (19.7%) stddev-sans-first:23.19 02:08:16 INFO - PROCESS | 2000 | Values: 145.0 108.0 104.0 171.0 109.0 104.0 128.0 105.0 141.0 106.0 02:08:16 INFO - PROCESS | 2000 | 02:08:16 INFO - PROCESS | 2000 | [#2] audio-dft Cycles:10 Average:183.00 Median:183.00 stddev:2.58 (1.4%) stddev-sans-first:2.64 02:08:16 INFO - PROCESS | 2000 | Values: 181.0 183.0 185.0 188.0 183.0 184.0 183.0 182.0 178.0 183.0 02:08:16 INFO - PROCESS | 2000 | 02:08:16 INFO - PROCESS | 2000 | [#3] audio-fft Cycles:10 Average:77.60 Median:72.00 stddev:19.05 (26.5%) stddev-sans-first:20.21 02:08:16 INFO - PROCESS | 2000 | Values: 78.0 60.0 74.0 115.0 83.0 82.0 70.0 56.0 101.0 57.0 02:08:16 INFO - PROCESS | 2000 | 02:08:16 INFO - PROCESS | 2000 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:69.00 stddev:24.40 (35.4%) stddev-sans-first:25.88 02:08:16 INFO - PROCESS | 2000 | Values: 93.0 69.0 130.0 102.0 110.0 68.0 98.0 70.0 69.0 129.0 02:08:16 INFO - PROCESS | 2000 | 02:08:16 INFO - PROCESS | 2000 | [#5] imaging-gaussian-blur Cycles:10 Average:88.80 Median:89.00 stddev:2.70 (3.0%) stddev-sans-first:2.83 02:08:16 INFO - PROCESS | 2000 | Values: 90.0 87.0 90.0 87.0 89.0 85.0 89.0 87.0 89.0 95.0 02:08:16 INFO - PROCESS | 2000 | 02:08:16 INFO - PROCESS | 2000 | [#6] imaging-darkroom Cycles:10 Average:94.10 Median:94.00 stddev:1.10 (1.2%) stddev-sans-first:1.09 02:08:16 INFO - PROCESS | 2000 | Values: 93.0 94.0 94.0 94.0 93.0 94.0 97.0 94.0 94.0 94.0 02:08:16 INFO - PROCESS | 2000 | 02:08:16 INFO - PROCESS | 2000 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:84.00 stddev:20.77 (24.7%) stddev-sans-first:21.55 02:08:16 INFO - PROCESS | 2000 | Values: 84.0 86.0 84.0 88.0 83.0 104.0 134.0 134.0 84.0 83.0 02:08:16 INFO - PROCESS | 2000 | 02:08:16 INFO - PROCESS | 2000 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.00 stddev:1.06 (2.0%) stddev-sans-first:1.09 02:08:16 INFO - PROCESS | 2000 | Values: 54.0 53.0 52.0 53.0 53.0 55.0 53.0 53.0 55.0 52.0 02:08:16 INFO - PROCESS | 2000 | 02:08:16 INFO - PROCESS | 2000 | [#9] json-stringify-tinderbox Cycles:10 Average:73.40 Median:74.50 stddev:3.34 (4.5%) stddev-sans-first:2.22 02:08:16 INFO - PROCESS | 2000 | Values: 66.0 76.0 76.0 75.0 78.0 71.0 73.0 72.0 74.0 73.0 02:08:16 INFO - PROCESS | 2000 | 02:08:16 INFO - PROCESS | 2000 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:84.50 stddev:1.66 (2.0%) stddev-sans-first:1.72 02:08:16 INFO - PROCESS | 2000 | Values: 83.0 86.0 83.0 84.0 84.0 83.0 81.0 86.0 85.0 86.0 02:08:16 INFO - PROCESS | 2000 | 02:08:16 INFO - PROCESS | 2000 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:141.50 stddev:7.20 (5.1%) stddev-sans-first:7.45 02:08:16 INFO - PROCESS | 2000 | Values: 137.0 137.0 133.0 136.0 142.0 146.0 150.0 141.0 156.0 137.0 02:08:16 INFO - PROCESS | 2000 | 02:08:16 INFO - PROCESS | 2000 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.70 Median:167.50 stddev:15.71 (9.4%) stddev-sans-first:16.61 02:08:16 INFO - PROCESS | 2000 | Values: 170.0 168.0 192.0 212.0 165.0 167.0 166.0 166.0 165.0 166.0 02:08:16 INFO - PROCESS | 2000 | 02:08:16 INFO - PROCESS | 2000 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 02:08:16 INFO - PROCESS | 2000 | Values: 66.0 66.0 67.0 67.0 66.0 66.0 66.0 65.0 66.0 65.0 02:08:16 INFO - PROCESS | 2000 | -------- Summary: end -------- 02:08:16 INFO - PROCESS | 2000 | 02:08:17 INFO - TEST-INFO | 2000: exit 0 02:08:17 INFO - TEST-OK | kraken | took 59974ms 02:08:17 INFO - SUITE-END | took 1177s 02:08:18 INFO - Completed test suite (00:19:37) 02:08:18 INFO - javascript benchmark 02:08:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3305.884294049708, 3320.6015278166624, 3335.8665653373864, 3345.665433456656, 3374.2576633140716, 5465.07093794055, 5525.143602741577, 5598.1602759586085, 5611.859703507404, 5666.150077488379, 5575.303087114111, 5596.076647353182, 5624.859378515539, 5638.126090455976, 5644.350899646542, 5096.617753668471, 5133.897322053556, 5157.896842063156, 5158.742062896859, 5219.947800521984, 5187.247849061884, 5196.272521846944, 5198.168293073109, 5198.740062996854, 5205.817796377128, 5156.20078887773, 5173.120569503175, 5173.482651734816, 5175.870603234912, 5193.5325820676135, 5229.7385130743505, 5240.947590524084, 5262.657927234717, 5273.868153296198, 5316.255724198615, 5043.571296439807, 5048.7980480780725, 5100.846974590768, 5147.202183661501, 5171.379434467888, 5546.833594992157, 5557.944420555783, 5573.247611572427, 5599.832005039855, 5621.0, 6169.383061693839, 6182.69086545671, 6185.814425567195, 6189.442950134465, 6208.192934918477, 6077.118817771443, 6084.429671795072, 6148.292946311187, 6199.101130336121, 6243.001119820807, 5748.338941021794, 5801.187833703285, 5834.212381328552, 5835.299764028259, 5840.474357307863, 6291.5281353898645, 6293.748250070037, 6299.401556852092, 6309.7160627770945, 6311.0217916223055, 5856.882862342729, 5923.052311630118, 6080.300046138128, 6087.634741915499, 6091.756329746849, 5354.8661283467445, 5983.773326468064, 6094.235304088532, 6158.876822463615, 6213.937860621336, 5073.771680274396, 6098.268207815002, 6133.355997620275, 6135.171751813448, 6139.693015349215, 6013.1581578579035, 6121.84695382619, 6187.226596675416, 6195.783147589813, 6203.2245969253845, 4895.363602731622, 4923.48303428142, 4929.876753081202, 4932.630052746058, 4941.258811178352, 4433.7561434121435, 4459.665525085632, 4479.081788233404, 4482.910341793146, 4482.932756008662, 5531.834044978657, 5599.300087489064, 5606.24315717373, 5619.0, 5666.744996475169, 6217.564770466114, 6231.345708700612, 6259.342769009279, 6264.9373506265265, 6285.560010799291, 5517.420670829585, 5598.944010559923, 5600.551955843604, 5604.579656525777, 5637.436256374412, 5359.839204823861, 5421.078416669176, 5425.457454254622, 5429.538489228381, 5434.076207044812, 5707.286589176353, 5936.910946335808, 6264.59280146789, 6309.716062777186, 6313.55805093639, 4992.450830408725, 6239.78160764371, 6241.157443745036, 6257.906131407942, 6263.123162757309, 6247.687615619292, 6275.717592708248, 6305.2433707953505, 6311.810645680637, 6346.809595712136, 6152.292486364126, 6159.23009623797, 6162.322144564184, 6169.321374648875, 6192.969035154795, 6250.937490625036, 6255.124282600348, 6256.687165641791, 6258.937410625836, 6274.811755647155, 5792.768289268551, 5867.9413205867395, 5883.235179426647, 5964.284285885721, 5974.342822289632, 5605.943940560543, 5873.911891321719, 6023.0, 6098.024316109401, 6099.969500152648, 5927.407259274038, 5941.168236446987, 5950.553708471795, 5970.552208584287, 5973.880522389615, 6048.516118710405, 6087.573869829246, 6096.420840020191, 6112.8777424452155, 6139.877202456015, 5747.683877386784, 5750.396208398058, 5790.334111577223, 5842.970785146217, 5904.173415721888], "value": 5635.544561170972, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [468.5338088601842, 488.728755540675, 492.71668790445494, 510.14550627698594, 525.3931708876249, 30953.845230773844, 40526.79736601317, 41858.16283674325, 41951.16097678045, 44083.77958110205, 42958.14083718332, 43429.565704342946, 43448.78275608618, 43500.91247718809, 43553.7822310888, 9708.174805141554, 9913.157381622535, 9913.900860991405, 9919.20646348294, 9923.702288931343, 9648.276379271547, 9677.612895484172, 9772.120509154174, 9790.265730070238, 9794.314397992144, 9763.75590610237, 9807.460589667566, 9810.96984816591, 9818.50907454628, 9838.458884761336, 9721.90278097217, 9773.267004974585, 9803.656872009482, 9804.852927206026, 9826.361286516354, 9737.853932191023, 9836.704898853046, 9840.26198035143, 9840.753981150458, 9844.704658860246, 40452.19095618071, 40716.79641601773, 40727.7963610183, 40733.185336293405, 40767.388489172685, 3485.4771784232566, 3568.892933211982, 3640.4721315409383, 3671.229041901204, 3905.511811023622, 31514.212144696336, 31984.200394990312, 32828.507572386196, 32991.67008329934, 33004.17489562756, 3262.0866157475707, 3263.0700250428513, 3297.7032067114073, 3301.3727391795483, 3328.8335583220983, 448452.0, 450652.0, 453155.0, 454310.0, 454901.0, 33170.336593268, 58279.708601456725, 58590.4140958585, 58593.5351616213, 58762.118568220656, 33737.83131084329, 34890.82554587261, 35020.29959400798, 35297.29405411877, 35316.823415882754, 14691.485797997018, 14904.0, 14925.0, 14930.32813523394, 14952.953293269584, 12367.567135150226, 12413.813792793115, 12435.44040518179, 12435.75128497425, 12440.875591244152, 7727.304542591194, 7735.381169506426, 7808.336291415179, 7821.061472623322, 7852.84294314122, 2745.492083964473, 3164.604424446944, 3211.951820722691, 3211.988223709524, 3263.249452625862, 934.2245935873209, 1021.4280003198232, 1072.9248952573246, 1073.5276478349658, 1103.7406209540752, 27519.036833710725, 28203.57694634582, 29730.0, 30445.847770761004, 32720.181995449828, 947.5830634520789, 1018.6587493189865, 1099.082266307626, 1131.9943400282946, 1134.6142311614092, 15658.765118523232, 15687.215639217993, 15762.605934851721, 15875.682486350208, 15906.05923861548, 661611.0, 665847.0, 668629.0, 669721.0, 670580.0, 58522.70738646365, 58982.0, 59038.704806476555, 59120.70439647774, 59242.66815986582, 1237.07219585311, 1300.648824817294, 1359.9592012239648, 1389.9930500347434, 1420.3537390487304, 24097.879510603037, 29377.0, 31208.0, 31445.842770786, 31841.840790795897, 50426.49573504218, 51162.488375115776, 51256.23115653193, 51271.0, 51282.23076653779, 567726.0, 571338.0, 571387.0, 572091.0, 572925.0, 23061.88469057644, 25888.8705556471, 26170.476590468465, 26467.470650586496, 26564.0, 47900.520994791, 48343.0, 48642.81107350107, 49060.509394905595, 50318.24522632237, 40048.79975600103, 40206.0, 40427.0, 40848.89388826397, 41485.1702965945, 33295.0, 40021.39967900426, 40165.79917100396, 40401.595984039785, 41358.0, 31247.906323278577, 33651.66348336583, 34202.657973420944, 39588.60411395849, 39765.60234397619, 29171.85414073001, 34669.65330346664, 35260.64739352574, 35584.82207588945, 35766.46350304696, 25513.0, 25562.744372556037, 25619.0, 25696.87151564305, 26405.867970660023], "value": 18766.91387898767, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.65956256586736, 353.9716822654188, 371.9181780008399, 377.28504484002815, 405.5457887166374, 14998.875084368676, 17524.649507009854, 21146.0, 21301.573968520657, 21406.785932140672, 18089.005104719236, 18552.814471855276, 18576.721349179774, 19987.900060499676, 20918.581628367425, 5378.408375078739, 5844.853878653036, 6096.573239873211, 6098.359672234418, 6106.816795496142, 5918.526517878559, 6098.390160983889, 6101.35935726749, 6109.450149486545, 6118.632882027093, 5851.356350801409, 6050.304215015263, 6051.243594550681, 6054.6367217966845, 6162.938370616282, 6163.044728067134, 6208.627482351051, 6212.130301757735, 6212.9068063979075, 6220.657863817488, 5784.913226301609, 5988.880222395528, 6043.244594425697, 6045.848853778647, 6059.606125601866, 13313.933430332883, 13573.59279221625, 14849.406023759037, 26325.81533830982, 26648.60027099595, 1959.6374670685825, 2483.3915690655726, 2663.4007348346468, 2707.891684332624, 3011.412774508972, 10045.69862904114, 10101.19190464761, 10475.371477711362, 10498.475076246157, 10506.789864202674, 1799.8470130038963, 1804.0709034846934, 1832.7800663920416, 1845.7877344105466, 1875.3248830421037, 114724.42637786841, 121831.0, 122892.0, 123102.0, 124576.0, 11302.547898083985, 11620.709482263012, 11627.825582616268, 11638.301701897914, 11815.995640370493, 14419.567412977627, 14440.350184241734, 14449.78325325121, 14449.85550144485, 14470.20413877247, 7094.326039026284, 8343.624536895853, 8547.957260213783, 8602.225799678059, 8754.47473151613, 6932.549384290005, 8515.74452766418, 8525.693871942856, 8655.17775811297, 8882.689105881263, 4413.426254586947, 4458.331250312414, 4477.149341625146, 4580.885477863014, 4587.4036375271, 1571.8035245594301, 1754.5349633056285, 1820.8088150744245, 1918.6930091185623, 1927.6144771045847, 834.586879494654, 853.3642436384808, 1004.1414590525142, 1011.6661501704419, 1037.4812593703148, 21011.264605738725, 21344.252951146635, 21549.0, 21593.568128637653, 21750.89124554367, 805.8227190018187, 852.3905407633572, 925.153484561632, 943.0475220027685, 949.378157306965, 10920.617778377718, 11368.374739389248, 11432.256903301259, 11435.371054592077, 11446.942765286287, 588276.0, 601007.0, 605294.0, 608992.0, 609063.0, 119948.00389970787, 130201.0, 130691.0, 130746.0, 131175.7206069856, 948.7296120605595, 967.7000129959735, 981.3032746749744, 986.1568359052907, 988.0712130597359, 15093.849061509245, 18155.0, 19903.800961990193, 19962.500937476678, 19991.500212494804, 50258.24096156763, 56949.430505694414, 57241.0, 58691.826163477344, 58706.706466467396, 62220.37779622146, 75946.24053759391, 77582.2241777575, 77706.0, 78512.60743696245, 7991.120976692676, 8091.069527004234, 8249.83500329978, 8326.83346333082, 8336.374771892253, 12661.556845510731, 12840.550580730003, 13150.868491314965, 13633.113847599874, 13868.306584670525, 11506.13515174372, 11963.342016189194, 11966.9828064612, 12022.27866328023, 12060.155789094679, 11325.32048077085, 11414.201005929504, 11656.242344247597, 11888.76222475563, 11949.940250299042, 11281.943590281997, 11702.70743231392, 11919.582814601446, 12037.337946412681, 12148.817767733668, 6931.133608298963, 7138.928610713826, 7324.450666199949, 7998.40011999114, 8568.657253709782, 11041.951014653596, 11349.602763903224, 11722.88277117252, 11829.408529573659, 11841.703957401134], "value": 9582.845361940312, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1494.2976800903575, 1535.1633359818898, 1696.3892998520523, 1715.4682048564946, 1828.1499102917141, 7014.368706816385, 8080.232377924088, 8239.588020598969, 8605.483670979746, 8781.604827782749, 8367.916320836805, 8626.137386261371, 8637.006744224416, 8730.476171429718, 8735.606897689604, 2301.620232661609, 2326.499802542453, 2332.323626148415, 2339.7075365579303, 2345.7654234576576, 2063.515073957619, 2143.871367717934, 2288.2220045184636, 2321.570509455756, 2343.7304709958316, 2276.4991701825656, 2352.1532248390567, 2353.788159065684, 2356.0, 2356.0, 2313.8958746856265, 2337.6493525971155, 2341.630146364379, 2345.7419683834764, 2348.072511358021, 2317.9304620861403, 2336.380859072347, 2337.135259953828, 2346.7301260355107, 2354.21133920137, 8707.259882909897, 8778.990416102166, 8780.824383512358, 8791.824163516758, 8798.252148567379, 5129.0767661820855, 5181.0, 5253.474652534755, 5257.369115706101, 5259.815906443295, 3293.275479394529, 3446.4313388290902, 3492.14442461596, 3554.253606742587, 3561.82190890457, 1021.0657248617506, 1051.1905832509, 1051.9789604207872, 1067.1942683274156, 1075.8601381820313, 11458.598949036743, 11524.078073754079, 11545.365004924726, 11552.480138393792, 11564.95915367621, 3761.605031471711, 4456.532064133284, 4757.26262429324, 4759.0719809636785, 4770.522947705202, 9828.066333698287, 9830.0, 9837.655682051094, 9844.015598440099, 9872.111509964137, 5302.072137376021, 5302.2046692996355, 5304.045271851027, 5305.124654432053, 5322.654027488278, 4757.643176761757, 4789.688670236424, 4865.172920603506, 4871.464138944713, 4876.512348765095, 3876.573576906538, 3882.7282090253975, 3913.373860182357, 3966.5835087315995, 4039.030632648143, 1176.499987505324, 1209.5887398284626, 1235.857876344214, 1264.5890085722176, 1268.822364868919, 817.235884448043, 907.2107266678032, 916.8349697054595, 922.3635691372931, 931.2968708625081, 4751.358566593535, 5750.712464376765, 6092.543059270483, 6132.356102609251, 6174.722137503823, 803.9115697273295, 954.6038394066385, 955.6129767444196, 960.4957397366438, 991.038692468319, 4016.4577781999055, 4026.879193624196, 4070.7964601769795, 4145.233131870614, 4148.979255103705, 10265.846012309821, 10642.946785266178, 10645.520951557199, 10656.0, 10666.413347265974, 10028.197744180448, 10474.581016759397, 10494.055535001886, 10531.684049478528, 10621.0, 7971.641276142587, 8167.714130005421, 8188.426810123353, 8209.220124088082, 8210.671573137008, 5226.45122262157, 5435.93999170158, 5798.391168927202, 6025.126356678345, 6253.593516421418, 9715.979822118576, 9854.0, 9992.250581206294, 10014.549345279334, 10022.799544008933, 9931.0, 10037.49812509357, 10130.138938190335, 10133.746656333651, 10151.390916545031, 7454.739084132029, 7598.96200519016, 7616.961915190389, 7618.733344332922, 7627.885581716389, 8086.676532938616, 8107.959460202661, 8181.5500147490075, 8237.588120593826, 8281.0, 6083.7870674526175, 7427.294407031323, 7473.9379271354255, 7535.133459651991, 7570.05374328209, 7289.8177545559665, 7355.2277010913085, 7362.926370736224, 7373.815654608463, 7414.592197428978, 6959.965200173967, 6961.512694111364, 6990.196127445409, 7032.367086962198, 7051.964740176266, 4595.287730401793, 4635.745034023161, 4875.585575226004, 5038.722870242172, 5182.352205974254, 4601.33280674307, 4923.359963204761, 4940.654154209171, 5007.474215207497, 5215.843524694265], "value": 4543.939738556609, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.4663605510082, 297.510595071108, 308.77922285565825, 314.1846907275619, 318.1283283802382, 4480.0, 5353.464653534645, 5381.461853814617, 5414.779940224504, 5439.401665816767, 4637.118947399992, 4956.504349565042, 5081.568066714333, 5173.723561632879, 5355.892882142355, 3627.2745450909792, 4088.8568900088503, 4090.754554726711, 4098.405731168971, 4111.71218014739, 3402.489626556024, 4018.4775979122674, 4117.588241175873, 4129.339305711087, 4159.188958153161, 3271.5910511186103, 4021.5777343378963, 4035.919281614366, 4089.3457046872504, 4110.321796903522, 3545.663161999606, 4040.696947728932, 4047.797610119482, 4048.271311163989, 4062.4921884764403, 3494.2836718472904, 3496.4056110461283, 3501.28223714138, 3517.7009954153928, 3531.993381886176, 4732.550407711262, 4933.827316043958, 5142.794288228466, 5221.686698798084, 5258.158694608845, 3688.981555092207, 4217.873463796061, 4654.348391225231, 4659.4408670959365, 4784.856454306341, 5604.243427137325, 5618.381977982419, 5641.464060914206, 5662.886742265173, 5677.489025987681, 3861.9876496332904, 3871.032241939515, 3871.361225397806, 3882.611738826123, 3891.20230352777, 5585.078462053756, 5856.32652244993, 5900.957843876958, 5938.25771778532, 5988.640681559077, 3284.540164376989, 3911.8239679214503, 3932.3708206686792, 3939.940900886489, 4002.419649150915, 3958.4853968984426, 3980.2238563479846, 3998.7400818946676, 4011.2579172853116, 4017.879463616096, 3719.6466335698065, 4290.206311832321, 4327.004788898571, 4464.352668862996, 4662.836800711959, 4667.883302917387, 4956.4547899731, 5677.744501497443, 5725.685087320154, 5747.7413516391025, 1286.9511348251333, 1338.692100816798, 1353.729254149174, 1374.3471850870956, 1377.3801789194902, 840.9663613455516, 876.9473831569999, 896.9282457403392, 904.3946994085419, 909.5861383070819, 5089.51649593288, 5113.539781419616, 5113.769880355393, 5141.71720555373, 5149.845504634867, 5419.701916394557, 5665.065264231438, 5713.628614140151, 5720.68536230503, 5746.276117164917, 4666.903277729731, 4791.377120974251, 4832.173178690506, 5061.937527795631, 5132.974335128375, 2844.687084420712, 2959.393324368499, 2992.6558445779015, 2993.3863557970562, 3002.0523012238837, 4924.409070911442, 5528.336599607992, 5788.652680839163, 5850.3564607893095, 5857.384974577693, 4917.852464426073, 4991.80032798684, 5738.368779434259, 5771.797987070517, 5823.0, 4450.866474005785, 5125.462361291523, 5831.88336233273, 5833.833233353346, 5873.823785286449, 5372.892542149213, 5421.888512854935, 5442.775375540472, 5588.692621905671, 5675.9499492594005, 5181.844544663666, 5585.860353491195, 5589.211452335214, 5596.524295434933, 5602.5517958562405, 5332.813351532678, 5583.274174357308, 5802.4894938561565, 5814.0, 5862.186150647628, 3755.7934313611922, 3817.809109544456, 3823.4456003878727, 3828.5214348206473, 3838.5201849768778, 4665.300204969146, 5584.274044374205, 5610.689693081102, 5626.803061892814, 5637.915431268616, 4314.71954322968, 4611.123886461562, 4822.397200349957, 5511.263951855153, 5517.48269225966, 4728.503507131702, 5339.78640854377, 5462.781488740406, 5465.808696695596, 5477.452254774491, 5028.472010438852, 5159.432462429205, 5357.098230128248, 5371.328583927009, 5474.288342515607, 4756.9048619026735, 4841.878953026203, 5700.543956483389, 5707.343655479507, 5743.396943320891, 4740.3882679889, 5554.555635549065, 5587.55299576041, 5589.031787430969, 5607.186957891165], "value": 4061.633114908766, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.4439420660574, 726.6512074204381, 760.4600733479231, 776.2586729673162, 810.1627771903436, 15226.314815833286, 15754.054756714591, 16850.49448516545, 16887.0, 16887.915560422196, 14082.295885205749, 15239.085654860688, 15250.923745381286, 15283.694326113471, 15303.234838258099, 684.4797953555284, 693.9278814231999, 709.684190535212, 828.1511450762956, 863.6372723456132, 849.371465115816, 856.3235044314983, 860.7417774667574, 860.7718954477068, 861.1259571534897, 916.6241840845255, 918.0589895357278, 918.7703074231442, 919.1773362840254, 921.7188757428981, 908.0556221529667, 908.6774195160722, 909.4997751236859, 909.8544232922734, 910.3718434280391, 531.8537402214383, 564.3087218157765, 654.6006935769177, 666.2072134160334, 677.6036018928933, 15549.30028148736, 15613.609659758484, 15617.765733514007, 15624.843751562452, 15648.0, 13930.303484825718, 14357.353919073666, 14545.27273636314, 14547.563573092824, 14609.926950365287, 12803.80794288077, 12845.229286242855, 13069.934650326783, 13191.0, 13557.728845423135, 4540.682152249344, 4576.565226303496, 4599.103174880899, 4663.790129444149, 4743.905121897543, 111849.88150118476, 112780.0, 113029.43485282603, 115332.4233378836, 123602.76397236003, 11241.55033798639, 11379.54481820718, 11463.140264480196, 11464.54141834334, 11954.940225298818, 23364.53270934606, 23383.88308058449, 23402.64896026561, 23405.063797448252, 23411.063557457852, 8025.23760242776, 8188.795280117925, 8241.670333186605, 8291.668333266602, 8396.118407567117, 3924.646781789653, 4334.631556317685, 4337.652987760972, 4351.0, 4643.907121857612, 3467.4625433057918, 3584.372734771405, 3585.1933315004435, 3589.210373717778, 3589.7307701921936, 630.2489632753001, 636.8821767972939, 652.3281020548842, 655.8589903170841, 659.8749132728782, 537.6370949608998, 596.9194158788508, 611.703323887914, 624.4536030972898, 636.5575924732267, 9007.77480562978, 9085.954570227106, 9193.724188274362, 9221.216196623229, 9307.627694892128, 581.1697035437446, 632.844952986512, 636.6275728698671, 638.8339031851659, 640.5496648747164, 3649.9464264454705, 4259.61663450291, 4357.0, 4401.185780630593, 4408.603225709701, 101991.47012794814, 142144.0, 164265.0, 168088.15955920142, 170767.14616426837, 98773.50613246887, 113620.0, 114814.42592786983, 147337.0, 151228.24385878, 104324.0, 104396.08237217604, 112684.73152684829, 114769.4261528687, 116528.0, 7499.137599176164, 9661.420314781135, 9726.36778609388, 9796.069373409515, 10019.298649094493, 64137.0, 64376.0, 65024.37439064061, 66018.66990665016, 67159.66420167868, 93504.12991740264, 95559.41083776244, 96976.0, 99647.0, 99669.0, 9370.906290937004, 10702.357858528514, 11403.942980285046, 11444.656660300205, 13294.867051329364, 12850.67873303175, 12925.547605834126, 13333.133346332457, 13361.398737056661, 14468.27658617086, 11015.339079655247, 11819.468123934616, 13448.596542103362, 13587.116837405538, 14097.295135243401, 13516.189028658311, 14063.789043164155, 14209.715805684034, 14693.779593306323, 15067.623309417353, 11071.944640276746, 12396.822301881306, 13393.330333483482, 13663.316834158451, 13781.931090344886, 10482.895171048192, 10928.890711092787, 11588.594399195988, 11620.418979051183, 11881.5841445549, 9631.951840240754, 11458.598949036743, 11522.711932201762, 11796.29222246668, 11845.348505832262], "value": 7862.888859635391, "unit": "score"}], "name": "dromaeo_css", "value": 7265.4726086170285, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 114.0, 114.0, 113.0, 115.0, 113.0, 112.0, 113.0, 113.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 108.0, 104.0, 171.0, 109.0, 104.0, 128.0, 105.0, 141.0, 106.0], "value": 122.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 183.0, 185.0, 188.0, 183.0, 184.0, 183.0, 182.0, 178.0, 183.0], "value": 183.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 60.0, 74.0, 115.0, 83.0, 82.0, 70.0, 56.0, 101.0, 57.0], "value": 77.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 69.0, 130.0, 102.0, 110.0, 68.0, 98.0, 70.0, 69.0, 129.0], "value": 93.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 90.0, 87.0, 89.0, 85.0, 89.0, 87.0, 89.0, 95.0], "value": 88.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 93.0, 94.0, 97.0, 94.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 84.0, 88.0, 83.0, 104.0, 134.0, 134.0, 84.0, 83.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 53.0, 53.0, 55.0, 53.0, 53.0, 55.0, 52.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 76.0, 76.0, 75.0, 78.0, 71.0, 73.0, 72.0, 74.0, 73.0], "value": 73.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 83.0, 84.0, 84.0, 83.0, 81.0, 86.0, 85.0, 86.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 137.0, 133.0, 136.0, 142.0, 146.0, 150.0, 141.0, 156.0, 137.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 168.0, 192.0, 212.0, 165.0, 167.0, 166.0, 166.0, 165.0, 166.0], "value": 173.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 67.0, 66.0, 66.0, 66.0, 65.0, 66.0, 65.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1460.1999999999998, "alertThreshold": 2.0}]} 02:08:18 INFO - Return code: 0 02:08:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:08:18 INFO - # TBPL SUCCESS # 02:08:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:08:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:08:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:08:18 INFO - 2016-08-12 02:08:18.281 screenresolution[2004:12847] starting screenresolution argv=screenresolution get 02:08:18 INFO - 2016-08-12 02:08:18.284 screenresolution[2004:12847] Display 0: 1600x1200x32@60 02:08:18 INFO - 2016-08-12 02:08:18.291 screenresolution[2005:12850] starting screenresolution argv=screenresolution list 02:08:18 INFO - Available Modes on Display 0 02:08:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:08:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:08:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:08:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:08:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:08:18 INFO - Intel Iris: 02:08:18 INFO - Chipset Model: Intel Iris 02:08:18 INFO - Type: GPU 02:08:18 INFO - Bus: Built-In 02:08:18 INFO - VRAM (Dynamic, Max): 1536 MB 02:08:18 INFO - Vendor: Intel (0x8086) 02:08:18 INFO - Device ID: 0x0a2e 02:08:18 INFO - Revision ID: 0x0009 02:08:18 INFO - Displays: 02:08:18 INFO - Display: 02:08:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:08:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:08:18 INFO - Display Serial Number: 1600x1200 60 02:08:18 INFO - Main Display: Yes 02:08:18 INFO - Mirror: Off 02:08:18 INFO - Online: Yes 02:08:18 INFO - Rotation: Supported 02:08:18 INFO - Return code: 0 02:08:18 INFO - Running post-action listener: _resource_record_post_action 02:08:18 INFO - [mozharness: 2016-08-12 09:08:18.532178Z] Finished run-tests step (success) 02:08:18 INFO - Running post-run listener: _resource_record_post_run 02:08:18 INFO - Total resource usage - Wall time: 1213s; CPU: 53.0%; Read bytes: 303104; Write bytes: 702456320; Read time: 8; Write time: 1892 02:08:18 INFO - TinderboxPrint: CPU usage
53.4% 02:08:18 INFO - TinderboxPrint: I/O read bytes / time
303,104 / 8 02:08:18 INFO - TinderboxPrint: I/O write bytes / time
702,456,320 / 1,892 02:08:18 INFO - TinderboxPrint: CPU idle
2,262.3 (46.6%) 02:08:18 INFO - TinderboxPrint: CPU system
969.8 (20.0%) 02:08:18 INFO - TinderboxPrint: CPU user
1,621.6 (33.4%) 02:08:18 INFO - TinderboxPrint: Swap in / out
404,205,568 / 0 02:08:18 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 395153920; Write bytes: 390748160; Read time: 29594; Write time: 775 02:08:18 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 290816; Write bytes: 293898752; Read time: 7; Write time: 1070 02:08:18 INFO - Running post-run listener: _upload_blobber_files 02:08:18 INFO - Blob upload gear active. 02:08:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:08:19 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:08:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:08:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:08:19 INFO - (blobuploader) - INFO - Open directory for files ... 02:08:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:08:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:08:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:08:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:08:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:08:20 INFO - (blobuploader) - INFO - Done attempting. 02:08:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:08:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:08:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:08:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:08:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:08:21 INFO - (blobuploader) - INFO - Done attempting. 02:08:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:08:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:08:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:08:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:08:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:08:23 INFO - (blobuploader) - INFO - Done attempting. 02:08:23 INFO - (blobuploader) - INFO - Iteration through files over. 02:08:23 INFO - Return code: 0 02:08:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:08:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:08:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a53854e4b3c911c7db1314b71b925de0697dbdcff22d55a9f6d1acbd987577da42891953390c8da21cb94a4a291df6717cf1eafd43f0927bb0f16e03d7155bad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2999ffe814b46f90062be28822e17d23cc7bab2146b06e420c574794d1a5c4d956c8272bf61be4501c27640e373ebbe4551adea3ea2a2b2b4be3e0755bba740f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14621f238c32a232e7513fd082e6e0429c1facc68bb26eeb1796787d61854b1f08b5d5298954a03bfa18fb7015c0841550d1c333369589d9bb3111ae6cc3c1de"} 02:08:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:08:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:08:23 INFO - Contents: 02:08:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a53854e4b3c911c7db1314b71b925de0697dbdcff22d55a9f6d1acbd987577da42891953390c8da21cb94a4a291df6717cf1eafd43f0927bb0f16e03d7155bad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2999ffe814b46f90062be28822e17d23cc7bab2146b06e420c574794d1a5c4d956c8272bf61be4501c27640e373ebbe4551adea3ea2a2b2b4be3e0755bba740f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14621f238c32a232e7513fd082e6e0429c1facc68bb26eeb1796787d61854b1f08b5d5298954a03bfa18fb7015c0841550d1c333369589d9bb3111ae6cc3c1de"} 02:08:23 INFO - Running post-run listener: copy_logs_to_upload_dir 02:08:23 INFO - Copying logs to upload dir... 02:08:23 INFO - mkdir: /builds/slave/test/build/upload/logs 02:08:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.645622 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-08-12 02:08:23.523774) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 02:08:23.526879) ========= 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.lUmXLFd2oC/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.1dq94XUI3Z/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a53854e4b3c911c7db1314b71b925de0697dbdcff22d55a9f6d1acbd987577da42891953390c8da21cb94a4a291df6717cf1eafd43f0927bb0f16e03d7155bad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2999ffe814b46f90062be28822e17d23cc7bab2146b06e420c574794d1a5c4d956c8272bf61be4501c27640e373ebbe4551adea3ea2a2b2b4be3e0755bba740f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14621f238c32a232e7513fd082e6e0429c1facc68bb26eeb1796787d61854b1f08b5d5298954a03bfa18fb7015c0841550d1c333369589d9bb3111ae6cc3c1de"} build_url:https://queue.taskcluster.net/v1/task/QCojeHmkRmGpUeV3vJV5-w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011123 build_url: 'https://queue.taskcluster.net/v1/task/QCojeHmkRmGpUeV3vJV5-w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a53854e4b3c911c7db1314b71b925de0697dbdcff22d55a9f6d1acbd987577da42891953390c8da21cb94a4a291df6717cf1eafd43f0927bb0f16e03d7155bad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2999ffe814b46f90062be28822e17d23cc7bab2146b06e420c574794d1a5c4d956c8272bf61be4501c27640e373ebbe4551adea3ea2a2b2b4be3e0755bba740f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14621f238c32a232e7513fd082e6e0429c1facc68bb26eeb1796787d61854b1f08b5d5298954a03bfa18fb7015c0841550d1c333369589d9bb3111ae6cc3c1de"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 02:08:23.564059) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 02:08:23.564822) ========= 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.lUmXLFd2oC/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.1dq94XUI3Z/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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.005203 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 02:08:23.618553) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 02:08:23.619313) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 02:08:23.620135) ========= ========= Total master_lag: 0.21 =========